vm-test-run-switch-test-basics
checks.x86_64-linux.switchTest-basics
· build #48
· 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 # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.mlGLAtM4FG', 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: c6242822-7d7f-4f1a-a08b-5caea5b5be9f17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-09-29T03:55:28Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-09-29T03:55:28Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-09-29T03:55:28Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-09-29T03:55:28Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-09-29T03:55:28Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-09-29T03:55:28Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33machine # [2026-09-29T03:55:28Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34machine # [2026-09-29T03:55:28Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-09-29T03:55:28Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-09-29T03:55:28Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-09-29T03:55:28Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-29T03:55:28Z 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.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 202654machine # [ 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/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/init regInfo=/nix/.ro-store/yij8yg447gkxjki87ppglgvk8z1jac4f-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 455405813 cycles75machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns76machine # [ 0.000005] tsc: Detected 2400.012 MHz processor77machine # [ 0.000810] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000078machine # [ 0.000837] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs79machine # [ 0.000839] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT80machine # [ 0.002729] found SMP MP-table at [mem 0x000f5450-0x000f545f]81machine # [ 0.002740] Using GB pages for direct mapping82machine # [ 0.002804] RAMDISK: [mem 0x3e426000-0x3ffcffff]83machine # [ 0.002811] ACPI: Early table checksum verification disabled84machine # [ 0.002813] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )85machine # [ 0.002817] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)86machine # [ 0.002822] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)87machine # [ 0.002828] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)88machine # [ 0.002830] ACPI: FACS 0x000000003FFE0000 00004089machine # [ 0.002832] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)90machine # [ 0.002833] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)91machine # [ 0.002835] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)92machine # [ 0.002836] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)93machine # [ 0.002838] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]94machine # [ 0.002839] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]95machine # [ 0.002839] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]96machine # [ 0.002840] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]97machine # [ 0.002840] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]98machine # [ 0.002841] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]99machine # [ 0.002841] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]100machine # [ 0.003066] No NUMA configuration found101machine # [ 0.003067] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]102machine # [ 0.003069] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]103machine # [ 0.005691] Zone ranges:104machine # [ 0.005692] DMA [mem 0x0000000000001000-0x0000000000ffffff]105machine # [ 0.005694] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]106machine # [ 0.005695] Normal empty107machine # [ 0.005695] Device empty108machine # [ 0.005696] Movable zone start for each node109machine # [ 0.005697] Early memory node ranges110machine # [ 0.005697] node 0: [mem 0x0000000000001000-0x000000000009efff]111machine # [ 0.005698] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]112machine # [ 0.005699] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]113machine # [ 0.005720] On node 0, zone DMA: 1 pages in unavailable ranges114machine # [ 0.005983] On node 0, zone DMA: 97 pages in unavailable ranges115machine # [ 0.023877] On node 0, zone DMA32: 40 pages in unavailable ranges116machine # [ 0.024331] ACPI: PM-Timer IO Port: 0x608117machine # [ 0.024341] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])118machine # [ 0.024366] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23119machine # [ 0.024369] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)120machine # [ 0.024370] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)121machine # [ 0.024372] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)122machine # [ 0.024373] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)123machine # [ 0.024373] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)124machine # [ 0.024376] ACPI: Using ACPI (MADT) for SMP configuration information125machine # [ 0.024377] ACPI: HPET id: 0x8086a201 base: 0xfed00000126machine # [ 0.024380] TSC deadline timer available127machine # [ 0.024384] CPU topo: Max. logical packages: 1128machine # [ 0.024384] CPU topo: Max. logical dies: 1129machine # [ 0.024385] CPU topo: Max. dies per package: 1130machine # [ 0.024388] CPU topo: Max. threads per core: 1131machine # [ 0.024389] CPU topo: Num. cores per package: 1132machine # [ 0.024389] CPU topo: Num. threads per package: 1133machine # [ 0.024389] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs134machine # [ 0.024408] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()135machine # [ 0.024435] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]136machine # [ 0.024436] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]137machine # [ 0.024437] [mem 0x40000000-0xafffffff] available for PCI devices138machine # [ 0.024438] Booting paravirtualized kernel on KVM139machine # [ 0.024441] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns140machine # [ 0.028885] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1141machine # [ 0.031067] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152142machine # [ 0.031109] kvm-guest: PV spinlocks disabled, single CPU143machine # [ 0.031111] 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/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/init regInfo=/nix/.ro-store/yij8yg447gkxjki87ppglgvk8z1jac4f-closure-info/registration console=ttyS0,115200n8 console=tty0144machine # [ 0.031208] Unknown kernel command line parameters "regInfo=/nix/.ro-store/yij8yg447gkxjki87ppglgvk8z1jac4f-closure-info/registration", will be passed to user space.145machine # [ 0.031221] random: crng init done146machine # [ 0.031221] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes147machine # [ 0.031243] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)148machine # [ 0.031255] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)149machine # [ 0.031286] Fallback order for Node 0: 0150machine # [ 0.031288] Built 1 zonelists, mobility grouping on. Total pages: 262006151machine # [ 0.031289] Policy zone: DMA32152machine # [ 0.033731] mem auto-init: stack:all(zero), heap alloc:on, heap free:off153machine # [ 0.036172] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1154machine # [ 0.038811] allocated 2097152 bytes of page_ext155machine # [ 0.048565] ftrace: allocating 48804 entries in 192 pages156machine # [ 0.048568] ftrace: allocated 192 pages with 2 groups157machine # [ 0.049379] Dynamic Preempt: lazy158machine # [ 0.049536] rcu: Preemptible hierarchical RCU implementation.159machine # [ 0.049536] rcu: RCU event tracing is enabled.160machine # [ 0.049537] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.161machine # [ 0.049538] Trampoline variant of Tasks RCU enabled.162machine # [ 0.049539] Rude variant of Tasks RCU enabled.163machine # [ 0.049539] Tracing variant of Tasks RCU enabled.164machine # [ 0.049540] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.165machine # [ 0.049540] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1166machine # [ 0.049565] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.167machine # [ 0.049566] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168machine # [ 0.049567] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.169machine # [ 0.053914] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16170machine # [ 0.054189] rcu: srcu_init: Setting srcu_struct sizes based on contention.171machine # [ 0.054195] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns172machine # [ 0.054298] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)173machine # [ 0.057802] Console: colour VGA+ 80x25174machine # [ 0.057805] printk: legacy console [tty0] enabled175machine # [ 0.087295] printk: legacy console [ttyS0] enabled176machine # [ 0.193401] ACPI: Core revision 20250807177machine # [ 0.194315] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns178machine # [ 0.195979] APIC: Switch to symmetric I/O mode setup179machine # [ 0.197059] x2apic enabled180machine # [ 0.197804] APIC: Switched APIC routing to: physical x2apic181machine # [ 0.199716] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1182machine # [ 0.200782] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns183machine # [ 0.202580] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)184machine # [ 0.203662] x86/cpu: User Mode Instruction Prevention (UMIP) activated185machine # [ 0.204709] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127186machine # [ 0.205578] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0187machine # [ 0.206581] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto188machine # [ 0.207577] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl189machine # [ 0.208578] Transient Scheduler Attacks: Vulnerable: No microcode190machine # [ 0.210363] Spectre V2 : Mitigation: Enhanced / Automatic IBRS191machine # [ 0.211326] Speculative Return Stack Overflow: Mitigation: Safe RET192machine # [ 0.212391] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization193machine # [ 0.213584] Spectre V2 : Enabling IBPB for BPF194machine # [ 0.215155] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier195machine # [ 0.216578] active return thunk: srso_alias_return_thunk196machine # [ 0.217598] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'197machine # [ 0.218577] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'198machine # [ 0.219577] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'199machine # [ 0.220577] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'200machine # [ 0.221577] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'201machine # [ 0.222577] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'202machine # [ 0.224450] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'203machine # [ 0.225578] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256204machine # [ 0.226577] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64205machine # [ 0.227577] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512206machine # [ 0.228577] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024207machine # [ 0.229577] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8208machine # [ 0.230577] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.209machine # [ 0.264224] Freeing SMP alternatives memory: 44K210machine # [ 0.264580] pid_max: default: 32768 minimum: 301211machine # [ 0.265661] LSM: initializing lsm=capability,landlock,yama,bpf,ima212machine # [ 0.266681] landlock: Up and running.213machine # [ 0.267578] Yama: becoming mindful.214machine # [ 0.268705] LSM support for eBPF active215machine # [ 0.269465] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)216machine # [ 0.270600] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)217machine # [ 0.273151] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)218machine # [ 0.274124] Performance Events: Fam17h+ core perfctr, AMD PMU driver.219machine # [ 0.274582] ... version: 2220machine # [ 0.275327] ... bit width: 48221machine # [ 0.275580] ... generic counters: 6222machine # [ 0.276366] ... generic bitmap: 000000000000003f223machine # [ 0.276586] ... fixed-purpose counters: 0224machine # [ 0.277352] ... fixed-purpose bitmap: 0000000000000000225machine # [ 0.277580] ... value mask: 0000ffffffffffff226machine # [ 0.278507] ... max period: 00007fffffffffff227machine # [ 0.279305] ... global_ctrl mask: 000000000000003f228machine # [ 0.279676] signal: max sigframe size: 3376229machine # [ 0.280529] rcu: Hierarchical SRCU implementation.230machine # [ 0.281233] rcu: Max phase no-delay instances is 400.231machine # [ 0.286088] smp: Bringing up secondary CPUs ...232machine # [ 0.286593] smp: Brought up 1 node, 1 CPU233machine # [ 0.287334] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)234machine # [ 0.287760] Memory: 941804K/1048024K available (17263K kernel code, 2728K rwdata, 13660K rodata, 3656K init, 2968K bss, 98852K reserved, 0K cma-reserved)235machine # [ 0.288851] devtmpfs: initialized236machine # [ 0.289615] x86/mm: Memory block size: 128MB237machine # [ 0.291353] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)238machine # [ 0.292571] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).239machine # [ 0.293658] pinctrl core: initialized pinctrl subsystem240machine # [ 0.294853] PM: RTC time: 03:55:28, date: 2026-09-29241machine # [ 0.298263] NET: Registered PF_NETLINK/PF_ROUTE protocol family242machine # [ 0.298938] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations243machine # [ 0.299601] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations244machine # [ 0.300723] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations245machine # [ 0.301591] audit: initializing netlink subsys (disabled)246machine # [ 0.302747] thermal_sys: Registered thermal governor 'fair_share'247machine # [ 0.302749] thermal_sys: Registered thermal governor 'bang_bang'248machine # [ 0.303581] thermal_sys: Registered thermal governor 'step_wise'249machine # [ 0.304590] audit: type=2000 audit(1790654128.984:1): state=initialized audit_enabled=0 res=1250machine # [ 0.306584] thermal_sys: Registered thermal governor 'user_space'251machine # [ 0.306585] thermal_sys: Registered thermal governor 'power_allocator'252machine # [ 0.307593] cpuidle: using governor menu253machine # [ 0.309873] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5254machine # [ 0.311118] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]255machine # [ 0.311583] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry256machine # [ 0.312593] PCI: Using configuration type 1 for base access257machine # [ 0.313784] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.258machine # [ 0.320735] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages259machine # [ 0.321581] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page260machine # [ 0.326581] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages261machine # [ 0.327581] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page262machine # [ 0.337990] ACPI: Added _OSI(Module Device)263machine # [ 0.338581] ACPI: Added _OSI(Processor Device)264machine # [ 0.339348] ACPI: Added _OSI(Processor Aggregator Device)265machine # [ 0.348173] ACPI: 1 ACPI AML tables successfully acquired and loaded266machine # [ 0.351984] ACPI: Interpreter enabled267machine # [ 0.352595] ACPI: PM: (supports S0 S3 S4 S5)268machine # [ 0.353343] ACPI: Using IOAPIC for interrupt routing269machine # [ 0.355634] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug270machine # [ 0.356581] PCI: Using E820 reservations for host bridge windows271machine # [ 0.359645] ACPI: Enabled 2 GPEs in block 00 to 3F272machine # [ 0.365227] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])273machine # [ 0.365586] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]274machine # [ 0.366657] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]275machine # [ 0.367704] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]276machine # [ 0.368923] PCI host bridge to bus 0000:00277machine # [ 0.369585] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]278machine # [ 0.370582] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]279machine # [ 0.371580] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]280machine # [ 0.372580] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]281machine # [ 0.373580] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]282machine # [ 0.374580] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]283machine # [ 0.375580] pci_bus 0000:00: root bus resource [bus 00-ff]284machine # [ 0.376523] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint285machine # [ 0.378075] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint286machine # [ 0.380676] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]287machine # [ 0.381658] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]288machine # [ 0.382635] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]289machine # [ 0.384225] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]290machine # [ 0.385273] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint291machine # [ 0.388620] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]292machine # [ 0.389566] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]293machine # [ 0.390406] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]294machine # [ 0.391507] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]295machine # [ 0.393632] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint296machine # [ 0.396622] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]297machine # [ 0.397530] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]298machine # [ 0.398384] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]299machine # [ 0.400102] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint300machine # [ 0.403624] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]301machine # [ 0.404580] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]302machine # [ 0.405601] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]303machine # [ 0.407158] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint304machine # [ 0.409622] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]305machine # [ 0.410550] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]306machine # [ 0.411603] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]307machine # [ 0.412586] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]308machine # [ 0.414164] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint309machine # [ 0.415627] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]310machine # [ 0.416602] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]311machine # [ 0.418181] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint312machine # [ 0.419592] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]313machine # [ 0.420602] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]314machine # [ 0.422186] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint315machine # [ 0.423630] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]316machine # [ 0.424602] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]317machine # [ 0.426125] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint318machine # [ 0.428592] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]319machine # [ 0.429602] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]320machine # [ 0.431151] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint321machine # [ 0.433627] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]322machine # [ 0.434502] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]323machine # [ 0.435631] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]324machine # [ 0.437125] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint325machine # [ 0.439287] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]326machine # [ 0.439587] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]327machine # [ 0.440601] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]328machine # [ 0.442169] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint329machine # [ 0.443413] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]330machine # [ 0.444495] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint331machine # [ 0.446324] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]332machine # [ 0.446804] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint333machine # [ 0.448452] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]334machine # [ 0.449558] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint335machine # [ 0.452262] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]336machine # [ 0.452828] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint337machine # [ 0.453864] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO338machine # [ 0.454845] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint339machine # [ 0.456643] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]340machine # [ 0.457571] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]341machine # [ 0.458908] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint342machine # [ 0.460479] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]343machine # [ 0.464297] ACPI: PCI: Interrupt link LNKA configured for IRQ 10344machine # [ 0.464687] ACPI: PCI: Interrupt link LNKB configured for IRQ 10345machine # [ 0.465679] ACPI: PCI: Interrupt link LNKC configured for IRQ 11346machine # [ 0.466682] ACPI: PCI: Interrupt link LNKD configured for IRQ 11347machine # [ 0.467680] ACPI: PCI: Interrupt link LNKE configured for IRQ 10348machine # [ 0.468678] ACPI: PCI: Interrupt link LNKF configured for IRQ 10349machine # [ 0.469679] ACPI: PCI: Interrupt link LNKG configured for IRQ 11350machine # [ 0.470676] ACPI: PCI: Interrupt link LNKH configured for IRQ 11351machine # [ 0.471612] ACPI: PCI: Interrupt link GSIA configured for IRQ 16352machine # [ 0.472596] ACPI: PCI: Interrupt link GSIB configured for IRQ 17353machine # [ 0.473596] ACPI: PCI: Interrupt link GSIC configured for IRQ 18354machine # [ 0.474595] ACPI: PCI: Interrupt link GSID configured for IRQ 19355machine # [ 0.475600] ACPI: PCI: Interrupt link GSIE configured for IRQ 20356machine # [ 0.476592] ACPI: PCI: Interrupt link GSIF configured for IRQ 21357machine # [ 0.477592] ACPI: PCI: Interrupt link GSIG configured for IRQ 22358machine # [ 0.478592] ACPI: PCI: Interrupt link GSIH configured for IRQ 23359machine # [ 0.480591] iommu: Default domain type: Translated360machine # [ 0.481410] iommu: DMA domain TLB invalidation policy: lazy mode361machine # [ 0.482670] ACPI: bus type USB registered362machine # [ 0.483506] usbcore: registered new interface driver usbfs363machine # [ 0.484351] usbcore: registered new interface driver hub364machine # [ 0.484590] usbcore: registered new device driver usb365machine # [ 0.486640] NetLabel: Initializing366machine # [ 0.487338] NetLabel: domain hash size = 128367machine # [ 0.487580] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO368machine # [ 0.488614] NetLabel: unlabeled traffic allowed by default369machine # [ 0.489552] PCI: Using ACPI for IRQ routing370machine # [ 0.533982] pci 0000:00:01.0: vgaarb: setting as boot VGA device371machine # [ 0.534576] pci 0000:00:01.0: vgaarb: bridge control possible372machine # [ 0.534576] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none373machine # [ 0.534585] vgaarb: loaded374machine # [ 0.535372] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0375machine # [ 0.536245] hpet0: 3 comparators, 64-bit 100.000000 MHz counter376machine # [ 0.540671] clocksource: Switched to clocksource kvm-clock377machine # [ 0.544453] VFS: Disk quotas dquot_6.6.0378machine # [ 0.545205] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)379machine # [ 0.546644] pnp: PnP ACPI init380machine # [ 0.547537] ACPI: IRQ 4 override to edge(!), high(!)381machine # [ 0.548572] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved382machine # [ 0.550170] pnp: PnP ACPI: found 5 devices383machine # [ 0.557791] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns384machine # [ 0.559315] clocksource: Switched to clocksource acpi_pm385machine # [ 0.560342] NET: Registered PF_INET protocol family386machine # [ 0.561463] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)387machine # [ 0.579934] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)388machine # [ 0.582257] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)389machine # [ 0.583664] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)390machine # [ 0.585047] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)391machine # [ 0.586343] TCP: Hash tables configured (established 8192 bind 8192)392machine # [ 0.587530] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)393machine # [ 0.588854] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)394machine # [ 0.590017] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)395machine # [ 0.591271] NET: Registered PF_UNIX/PF_LOCAL protocol family396machine # [ 0.592329] NET: Registered PF_XDP protocol family397machine # [ 0.593247] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]398machine # [ 0.594317] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]399machine # [ 0.595418] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]400machine # [ 0.596590] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]401machine # [ 0.597740] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]402machine # [ 0.598874] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]403machine # [ 0.600716] ACPI: \_SB_.GSIA: Enabled at IRQ 16404machine # [ 0.603334] ACPI: \_SB_.GSIB: Enabled at IRQ 17405machine # [ 0.605326] ACPI: \_SB_.GSIC: Enabled at IRQ 18406machine # [ 0.607302] ACPI: \_SB_.GSID: Enabled at IRQ 19407machine # [ 0.609007] PCI: CLS 0 bytes, default 64408machine # [ 0.609899] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns409machine # [ 0.611689] Trying to unpack rootfs image as initramfs...410machine # [ 0.655543] Initialise system trusted keyrings411machine # [ 0.658550] workingset: timestamp_bits=40 max_order=18 bucket_order=0412machine # [ 0.678264] Key type asymmetric registered413machine # [ 0.683407] Asymmetric key parser 'x509' registered414machine # [ 0.684303] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)415machine # [ 0.687508] io scheduler mq-deadline registered416machine # [ 0.688335] io scheduler kyber registered417machine # [ 0.691965] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled418machine # [ 0.693323] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A419machine # [ 0.698545] Linux agpgart interface v0.103420machine # [ 0.699354] ACPI: bus type drm_connector registered421machine # [ 0.702711] usbcore: registered new interface driver usbserial_generic422machine # [ 0.703858] usbserial: USB Serial support registered for generic423machine # [ 0.707414] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.424machine # [ 0.707414] Please enable it if your BIOS has the CPPC option.425machine # [ 0.709711] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled426machine # [ 0.712529] drop_monitor: Initializing network drop monitor service427machine # [ 0.713792] NET: Registered PF_INET6 protocol family428machine # [ 0.716926] Segment Routing with IPv6429machine # [ 0.720421] In-situ OAM (IOAM) with IPv6430machine # [ 0.721509] IPI shorthand broadcast: enabled431machine # [ 0.729942] sched_clock: Marking stable (586015382, 143382039)->(810527448, -81130027)432machine # [ 0.735564] registered taskstats version 1433machine # [ 0.736584] Loading compiled-in X.509 certificates434machine # [ 0.755687] Demotion targets for Node 0: null435machine # [ 0.756611] Key type .fscrypt registered436machine # [ 0.757339] Key type fscrypt-provisioning registered437machine # [ 0.759529] ima: No TPM chip found, activating TPM-bypass!438machine # [ 0.760513] ima: Allocated hash algorithm: sha1439machine # [ 0.761356] ima: No architecture policies found440machine # [ 0.766590] PM: Magic number: 10:405:918441machine # [ 0.768249] RAS: Correctable Errors collector initialized.442machine # [ 0.778117] clk: Disabling unused clocks443machine # [ 0.780412] PM: genpd: Disabling unused power domains444machine # [ 0.958213] Freeing initrd memory: 28328K445machine # [ 0.961461] Freeing unused decrypted memory: 2028K446machine # [ 0.964134] Freeing unused kernel image (initmem) memory: 3656K447machine # [ 0.965272] Write protecting the kernel read-only data: 32768k448machine # [ 0.967181] Freeing unused kernel image (text/rodata gap) memory: 1168K449machine # [ 0.968733] Freeing unused kernel image (rodata/data gap) memory: 676K450machine # [ 1.019540] x86/mm: Checked W+X mappings: passed, no W+X pages found.451machine # [ 1.020703] Run /init as init process452machine # [ 1.031600] systemd[1]: Inserted module 'autofs4'453machine # [ 1.051587] fuse: init (API version 7.45)454machine # [ 1.059027] ACPI: \_SB_.GSIG: Enabled at IRQ 22455machine # [ 1.061794] ACPI: \_SB_.GSIH: Enabled at IRQ 23456machine # [ 1.065103] ACPI: \_SB_.GSIE: Enabled at IRQ 20457machine # [ 1.067494] ACPI: \_SB_.GSIF: Enabled at IRQ 21458machine # [ 1.073275] virtiofs virtio5: discovered new tag: nix-store459machine # [ 1.074911] virtiofs virtio5: virtio_fs_setup_dax: No cache capability460machine # [ 1.082349] virtiofs virtio6: discovered new tag: shared461machine # [ 1.083956] virtiofs virtio6: virtio_fs_setup_dax: No cache capability462machine # [ 1.088597] virtiofs virtio7: discovered new tag: xchg463machine # [ 1.090213] virtiofs virtio7: virtio_fs_setup_dax: No cache capability464machine # [ 1.112650] systemd[1]: Successfully made /usr/ read-only.465machine # [ 1.114940] systemd[1]: systemd 263-583679f 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)466machine # [ 1.120190] systemd[1]: Detected virtualization kvm.467machine # [ 1.121130] systemd[1]: Detected architecture x86-64.468machine # [ 1.122052] systemd[1]: Running in initrd.469machine # [ 1.123115] systemd[1]: Initializing machine ID from random generator.470machine # [ 1.124460] systemd[1]: Hostname set to <machine>.471machine # [ 1.199760] systemd[1]: bpf-restrict-fs: LSM BPF program attached472machine # [ 1.237903] systemd[1]: Queued start job for default target Initrd Default Target.473machine # [ 1.241714] systemd[1]: Created slice Slice /system/modprobe.474machine # [ 1.242894] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.475machine # [ 1.244336] systemd[1]: Expecting device /dev/disk/by-label/nixos...476machine # [ 1.245506] systemd[1]: Reached target Path Units.477machine # [ 1.246458] systemd[1]: Reached target Slice Units.478machine # [ 1.247357] systemd[1]: Reached target Swaps.479machine # [ 1.248202] systemd[1]: Reached target Timer Units.480machine # [ 1.249224] systemd[1]: Listening on D-Bus System Message Bus Socket.481machine # [ 1.250504] systemd[1]: Listening on Journal Socket (/dev/log).482machine # [ 1.251714] systemd[1]: Listening on Journal Sockets.483machine # [ 1.252708] systemd[1]: Listening on udev Kernel Socket.484machine # [ 1.253669] systemd[1]: Reached target Socket Units.485machine # [ 1.255559] systemd[1]: Starting Create List of Static Device Nodes...486machine # [ 1.259264] systemd[1]: Starting Load Kernel Module configfs...487machine # [ 1.270486] systemd[1]: Starting Journal Service...488machine # [ 1.280166] systemd[1]: Starting Load Kernel Modules...489machine # [ 1.296644] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os490machine # [ 1.305492] systemd[1]: Starting Coldplug All udev Devices...491machine # [ 1.318904] systemd[1]: Finished Create List of Static Device Nodes.492machine # [ 1.326144] systemd[1]: modprobe@configfs.service: Deactivated successfully.493machine # [ 1.333799] systemd[1]: Finished Load Kernel Module configfs.494machine # [ 1.335323] systemd-journald[65]: Collecting audit messages is disabled.495machine # [ 1.339868] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config496machine # [ 1.352482] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...497machine # [ 1.354823] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.498machine # [ 1.364424] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev499machine # [ 1.395495] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.500machine # [ 1.404491] systemd[1]: Starting Create Static Device Nodes in /dev...501machine # [ 1.414993] systemd[1]: Finished Load Kernel Modules.502machine # [ 1.424173] systemd[1]: Starting Apply Kernel Variables...503machine # [ 1.445528] systemd[1]: Finished Create Static Device Nodes in /dev.504machine # [ 1.451626] systemd[1]: Reached target Preparation for Local File Systems.505machine # [ 1.457496] systemd[1]: Reached target Local File Systems.506machine # [ 1.310919] systemd-modules-load[66]: Inserted module 'dm_mod'507machine # [ 1.317054] systemd-modules-load[66]: Inserted module 'virtio_balloon'508machine # [ 1.319907] systemd-modules-load[66]: Inserted module 'virtio_gpu'509machine # [ 1.465598] systemd[1]: Starting Rule-based Manager for Device Events and Files...510machine # [ 1.472700] systemd[1]: Started Journal Service.511machine # [ 1.336247] systemd[1]: Finished Apply Kernel Variables.512machine # [ 1.348613] systemd[1]: Starting Create System Files and Directories...513machine # [ 1.380413] systemd[1]: Finished Create System Files and Directories.514machine # [ 1.386362] systemd-udevd[73]: Using default interface naming scheme 'v261'.515machine # [ 1.409152] systemd[1]: Started Rule-based Manager for Device Events and Files.516machine # [ 1.467091] systemd[1]: Finished Coldplug All udev Devices.517machine # [ 1.467960] systemd[1]: Reached target System Initialization.518machine # [ 1.468832] systemd[1]: Reached target Basic System.519machine # [ 1.795889] virtio_blk virtio2: 1/0/0 default/read/poll queues520machine # [ 1.797756] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12521machine # [ 1.806454] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)522machine # [ 1.812118] serio: i8042 KBD port at 0x60,0x64 irq 1523machine # [ 1.817412] serio: i8042 AUX port at 0x60,0x64 irq 12524machine # [ 1.838296] ehci-pci 0000:00:1d.7: EHCI Host Controller525machine # [ 1.839093] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1526machine # [ 1.840953] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000527machine # [ 1.848417] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00528machine # [ 1.849367] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18529machine # [ 1.851881] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1530machine # [ 1.854630] usb usb1: Product: EHCI Host Controller531machine # [ 1.855338] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd532machine # [ 1.856752] usb usb1: SerialNumber: 0000:00:1d.7533machine # [ 1.858469] hub 1-0:1.0: USB hub found534machine # [ 1.860840] hub 1-0:1.0: 6 ports detected535machine # [ 1.864425] uhci_hcd 0000:00:1d.0: UHCI Host Controller536machine # [ 1.865260] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2537machine # [ 1.875871] uhci_hcd 0000:00:1d.0: detected 2 ports538machine # [ 1.880692] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180539machine # [ 1.889769] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18540machine # [ 1.891000] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1541machine # [ 1.908316] usb usb2: Product: UHCI Host Controller542machine # [ 1.909182] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd543machine # [ 1.911516] usb usb2: SerialNumber: 0000:00:1d.0544machine # [ 1.915776] SCSI subsystem initialized545machine # [ 1.775674] systemd[1]: Starting Virtual Console Setup...546machine # [ 1.925067] hub 2-0:1.0: USB hub found547machine # [ 1.937436] hub 2-0:1.0: 2 ports detected548machine # [ 1.809751] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.549machine # [ 1.956140] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0550machine # [ 1.814842] systemd[1]: Finished Virtual Console Setup.551machine # [ 1.822818] (udev-worker)[86]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.552machine # [ 1.971933] uhci_hcd 0000:00:1d.1: UHCI Host Controller553machine # [ 1.972688] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3554machine # [ 1.832722] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.555machine # [ 1.844052] systemd[1]: Found device /dev/disk/by-label/nixos.556machine # [ 1.845774] systemd[1]: Reached target Initrd Root Device.557machine # [ 1.850068] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...558machine # [ 1.994628] uhci_hcd 0000:00:1d.1: detected 2 ports559machine # [ 2.001125] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0560machine # [ 2.007954] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18561machine # [ 2.009111] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1562machine # [ 2.015764] usb usb3: Product: UHCI Host Controller563machine # [ 2.017453] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd564machine # [ 2.018229] usb usb3: SerialNumber: 0000:00:1d.1565machine # [ 2.020980] hub 3-0:1.0: USB hub found566machine # [ 2.023459] hub 3-0:1.0: 2 ports detected567machine # [ 2.032534] uhci_hcd 0000:00:1d.2: UHCI Host Controller568machine # [ 2.033337] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4569machine # [ 1.891584] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks570machine # [ 2.041095] uhci_hcd 0000:00:1d.2: detected 2 ports571machine # [ 1.899461] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.572machine # [ 2.043992] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0573machine # [ 2.047726] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18574machine # [ 2.049471] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1575machine # [ 2.054580] usb usb4: Product: UHCI Host Controller576machine # [ 2.057448] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd577machine # [ 2.058289] usb usb4: SerialNumber: 0000:00:1d.2578machine # [ 2.062017] hub 4-0:1.0: USB hub found579machine # [ 2.066617] hub 4-0:1.0: 2 ports detected580machine # [ 2.082011] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode581machine # [ 2.091416] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)582machine # [ 2.092293] ahci 0000:00:1f.2: flags: 64bit ncq only583machine # [ 2.101482] scsi host0: ahci584machine # [ 2.102497] usb 1-1: new high-speed USB device number 2 using ehci-pci585machine # [ 2.104513] scsi host1: ahci586machine # [ 2.105705] scsi host2: ahci587machine # [ 2.107478] scsi host3: ahci588machine # [ 2.109993] scsi host4: ahci589machine # [ 2.111737] scsi host5: ahci590machine # [ 2.112276] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1591machine # [ 2.114544] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1592machine # [ 2.115806] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1593machine # [ 2.117221] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1594machine # [ 2.118446] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1595machine # [ 2.119709] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1596machine # [ 2.233626] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00597machine # [ 2.236675] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10598machine # [ 2.239765] usb 1-1: Product: QEMU USB Tablet599machine # [ 2.241594] usb 1-1: Manufacturer: QEMU600machine # [ 2.243268] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1601machine # [ 2.276208] hid: raw HID events driver (C) Jiri Kosina602machine # [ 2.171566] systemd[1]: Mounting /sysroot...603machine # [ 2.429469] ata2: SATA link down (SStatus 0 SControl 300)604machine # [ 2.430361] ata1: SATA link down (SStatus 0 SControl 300)605machine # [ 2.431465] ata5: SATA link down (SStatus 0 SControl 300)606machine # [ 2.432318] ata4: SATA link down (SStatus 0 SControl 300)607machine # [ 2.433371] ata6: SATA link down (SStatus 0 SControl 300)608machine # [ 2.434304] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)609machine # [ 2.435271] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100610machine # [ 2.436080] ata3.00: applying bridge limits611machine # [ 2.436908] ata3.00: configured for UDMA/100612machine # [ 2.443827] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5613machine # [ 2.522507] usbcore: registered new interface driver usbhid614machine # [ 2.523348] usbhid: USB HID core driver615machine # [ 2.542535] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray616machine # [ 2.556522] cdrom: Uniform CD-ROM driver Revision: 3.20617machine # [ 2.558513] 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/input2618machine # [ 2.560714] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0619machine # [ 2.573590] EXT4-fs (vda): mounted filesystem c6242822-7d7f-4f1a-a08b-5caea5b5be9f r/w with ordered data mode. Quota mode: none.620machine # [ 2.436880] systemd[1]: Mounted /sysroot.621machine # [ 2.440737] systemd[1]: Reached target Initrd Root File System.622machine # [ 2.441889] systemd[1]: Starting Mountpoints Configured in the Real Root...623machine # [ 2.460173] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.624machine # [ 2.463044] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...625machine # [ 2.464499] systemd[1]: Reloading...626machine # [ 2.543241] systemd[1]: Reloading finished in 77 ms.627machine # [ 2.551765] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...628machine # [ 2.557266] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...629machine # [ 2.563797] systemd[1]: initrd-parse-etc.service: Deactivated successfully.630machine # [ 2.565905] systemd[1]: Finished Mountpoints Configured in the Real Root.631machine # [ 2.567093] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.632machine # [ 3.174282] systemd[1]: Mounting /sysroot/nix/.ro-store...633machine # [ 3.180164] systemd[1]: Mounting /sysroot/nix/.rw-store...634machine # [ 3.190187] systemd[1]: Mounting /sysroot/run...635machine # [ 3.201178] systemd[1]: Mounting /sysroot/tmp/shared...636machine # [ 3.213645] systemd[1]: Mounting /sysroot/tmp/xchg...637machine # [ 3.246797] systemd[1]: Mounted /sysroot/nix/.ro-store.638machine # [ 3.253061] systemd[1]: Mounted /sysroot/nix/.rw-store.639machine # [ 3.262557] systemd[1]: Mounted /sysroot/run.640machine # [ 3.266208] systemd[1]: Mounted /sysroot/tmp/shared.641machine # [ 3.268322] systemd[1]: Mounted /sysroot/tmp/xchg.642machine # [ 3.271261] systemd[1]: Starting rw-sysroot-nix-store.service...643machine # [ 3.283410] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.644machine # [ 3.284929] systemd[1]: Finished rw-sysroot-nix-store.service.645machine # [ 4.173143] systemd[1]: Mounting /sysroot/nix/store...646machine # [ 4.205322] systemd[1]: Mounted /sysroot/nix/store.647machine # [ 4.207418] systemd[1]: Reached target Initrd File Systems.648machine # [ 4.210100] systemd[1]: Starting Find NixOS closure...649machine # [ 4.212830] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...650machine # [ 4.237559] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.651machine # [ 4.240154] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.652machine # [ 4.246539] systemd[1]: Finished Find NixOS closure.653machine # [ 4.247686] systemd[1]: Reached target Initrd Default Target.654machine # [ 4.249442] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...655machine # [ 4.264908] systemd[1]: Stopped target Initrd Default Target.656machine # [ 4.266214] systemd[1]: Stopped target Basic System.657machine # [ 4.268129] systemd[1]: Stopped target Initrd Root Device.658machine # [ 4.268939] systemd[1]: Stopped target Path Units.659machine # [ 4.269638] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.660machine # [ 4.270706] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.661machine # [ 4.271960] systemd[1]: Stopped target Slice Units.662machine # [ 4.272737] systemd[1]: Stopped target Socket Units.663machine # [ 4.273675] systemd[1]: Stopped target System Initialization.664machine # [ 4.274742] systemd[1]: Stopped target Swaps.665machine # [ 4.275631] systemd[1]: Stopped target Timer Units.666machine # [ 4.276743] systemd[1]: dbus.socket: Deactivated successfully.667machine # [ 4.278161] systemd[1]: Closed D-Bus System Message Bus Socket.668machine # [ 4.279057] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.669machine # [ 4.280612] systemd[1]: Stopped Find NixOS closure.670machine # [ 4.281718] systemd[1]: Starting rw-sysroot-nix-store.service...671machine # [ 4.282614] systemd[1]: systemd-sysctl.service: Deactivated successfully.672machine # [ 4.284327] systemd[1]: Stopped Apply Kernel Variables.673machine # [ 4.285346] systemd[1]: systemd-modules-load.service: Deactivated successfully.674machine # [ 4.286549] systemd[1]: Stopped Load Kernel Modules.675machine # [ 4.288131] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.676machine # [ 4.289189] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.677machine # [ 4.290372] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.678machine # [ 4.291397] systemd[1]: Stopped Create System Files and Directories.679machine # [ 4.292304] systemd[1]: Stopped target Local File Systems.680machine # [ 4.294116] systemd[1]: Stopped target Preparation for Local File Systems.681machine # [ 4.295043] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.682machine # [ 4.296143] systemd[1]: Stopped Coldplug All udev Devices.683machine # [ 4.298122] systemd[1]: Stopping Rule-based Manager for Device Events and Files...684machine # [ 4.299199] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.685machine # [ 4.300241] systemd[1]: Stopped Virtual Console Setup.686machine # [ 4.310245] systemd[1]: initrd-cleanup.service: Deactivated successfully.687machine # [ 4.316179] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.688machine # [ 4.317240] systemd[1]: systemd-udevd.service: Deactivated successfully.689machine # [ 4.318365] systemd[1]: Stopped Rule-based Manager for Device Events and Files.690machine # [ 4.326069] systemd[1]: Starting Cleanup udev Database...691machine # [ 4.327079] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.692machine # [ 4.329165] systemd[1]: Stopped Create Static Device Nodes in /dev.693machine # [ 4.330161] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.694machine # [ 4.331312] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.695machine # [ 4.333175] systemd[1]: kmod-static-nodes.service: Deactivated successfully.696machine # [ 4.334182] systemd[1]: Stopped Create List of Static Device Nodes.697machine # [ 4.335160] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.698machine # [ 4.337135] systemd[1]: Finished rw-sysroot-nix-store.service.699machine # [ 4.353431] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.700machine # [ 4.355086] systemd[1]: Finished Cleanup udev Database.701machine # [ 4.356257] systemd[1]: Reached target Switch Root.702machine # [ 4.358066] systemd[1]: Starting NixOS Activation...703machine # [ 4.433569] initrd-nixos-activation-start[188]: booting system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test704machine # [ 4.462550] initrd-nixos-activation-start[188]: running activation script...705machine # [ 4.677351] initrd-nixos-activation-start[211]: setting up /etc...706machine # [ 4.783669] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.707machine # [ 4.785084] systemd[1]: Finished NixOS Activation.708machine # [ 4.787071] systemd[1]: Starting Switch Root...709machine # [ 4.800250] systemd[1]: Switching root.710machine # [ 5.066217] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).711machine # [ 5.120747] NET: Registered PF_VSOCK protocol family712machine # [ 5.145308] systemd[1]: systemd 263-583679f 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)713machine # [ 5.149257] systemd[1]: Detected virtualization kvm.714machine # [ 5.149989] systemd[1]: Detected architecture x86-64.715machine # [ 5.150727] systemd[1]: Detected first boot.716machine # [ 5.152323] systemd[1]: Initializing machine ID from random generator.717machine # [ 5.241482] systemd[1]: bpf-restrict-fs: LSM BPF program attached718machine # [ 5.337308] systemd[1]: Applying preset policy.719machine # [ 5.507848] systemd[1]: Populated /etc with preset unit settings.720machine # [ 5.698461] systemd[1]: initrd-switch-root.service: Deactivated successfully.721machine # [ 5.699926] systemd[1]: Stopped initrd-switch-root.service.722machine # [ 5.701909] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.723machine # [ 5.703956] systemd[1]: Created slice Slice /system/getty.724machine # [ 5.705236] systemd[1]: Created slice User and Session Slice.725machine # [ 5.706202] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.726machine # [ 5.707464] systemd[1]: Started Forward Password Requests to Wall Directory Watch.727machine # [ 5.708609] systemd[1]: Expecting device /dev/hvc0...728machine # [ 5.709323] systemd[1]: Expecting device /dev/ttyS0...729machine # [ 5.710119] systemd[1]: Reached target Local Encrypted Volumes.730machine # [ 5.710978] systemd[1]: Stopped target initrd-fs.target.731machine # [ 5.711720] systemd[1]: Stopped target initrd-root-fs.target.732machine # [ 5.712513] systemd[1]: Stopped target initrd-switch-root.target.733machine # [ 5.713394] systemd[1]: Reached target Virtual Machines and Containers.734machine # [ 5.714316] systemd[1]: Reached target Path Units.735machine # [ 5.715055] systemd[1]: Reached target Remote File Systems.736machine # [ 5.715827] systemd[1]: Reached target Slice Units.737machine # [ 5.716549] systemd[1]: Reached target Swaps.738machine # [ 5.718206] systemd[1]: Listening on Query the User Interactively for a Password.739machine # [ 5.732320] systemd[1]: Listening on Process Core Dump Socket.740machine # [ 5.734004] systemd[1]: Listening on Credential Encryption/Decryption.741machine # [ 5.735736] systemd[1]: Listening on Factory Reset Management.742machine # [ 5.736646] systemd[1]: Listening on Hostname Service Socket.743machine # [ 5.739283] systemd[1]: Starting Journal Log Access Socket...744machine # [ 5.740819] systemd[1]: Listening on Journal Audit Socket.745machine # [ 5.743514] systemd[1]: Listening on Console Output Muting Service Socket.746machine # [ 5.744631] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.747machine # [ 5.745775] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os748machine # [ 5.747095] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki749machine # [ 5.750865] systemd[1]: Listening on Disk Repartitioning Service Socket.750machine # [ 5.751880] systemd[1]: Listening on udev Varlink Socket.751machine # [ 5.754106] systemd[1]: Mounting Huge Pages File System...752machine # [ 5.757546] systemd[1]: Mounting POSIX Message Queue File System...753machine # [ 5.764592] systemd[1]: Mounting Kernel Debug File System...754machine # [ 5.771653] systemd[1]: Mounting Kernel Trace File System...755machine # [ 5.778824] systemd[1]: Starting Create List of Static Device Nodes...756machine # [ 5.791591] systemd[1]: Starting Load Kernel Module configfs...757machine # [ 5.799832] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm758machine # [ 5.811145] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore759machine # [ 5.821095] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse760machine # [ 5.833268] systemd[1]: Mounting FUSE Control File System...761machine # [ 5.835924] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67762machine # [ 5.848327] systemd[1]: Starting Journal Service...763machine # [ 5.851624] systemd[1]: Starting Load Kernel Modules...764machine # [ 5.857705] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...765machine # [ 5.868788] systemd[1]: Starting Remount Root and Kernel File Systems...766machine # [ 5.878501] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os767machine # [ 5.892062] systemd[1]: Starting Coldplug All udev Devices...768machine # [ 5.899101] systemd[1]: Listening on Journal Log Access Socket.769machine # [ 5.905538] systemd[1]: Mounted Huge Pages File System.770machine # [ 5.907737] systemd[1]: Mounted POSIX Message Queue File System.771machine # [ 5.910459] systemd[1]: Mounted Kernel Debug File System.772machine # [ 5.913498] systemd[1]: Mounted Kernel Trace File System.773machine # [ 5.922557] systemd[1]: Finished Create List of Static Device Nodes.774machine # [ 5.925599] systemd-journald[282]: Collecting audit messages is enabled.775machine # [ 5.931229] systemd[1]: modprobe@configfs.service: Deactivated successfully.776machine # [ 5.936447] systemd[1]: Finished Load Kernel Module configfs.777machine # [ 5.803772] systemd[1]: Queued start job for default target Multi-User System.778machine # [ 5.948610] systemd[1]: Mounting Kernel Configuration File System...779machine # [ 5.807274] systemd[1]: systemd-journald.service: Deactivated successfully.780machine # [ 5.964508] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...781machine # [ 5.969395] EXT4-fs (vda): re-mounted c6242822-7d7f-4f1a-a08b-5caea5b5be9f.782machine # [ 5.972739] systemd[1]: Started Journal Service.783machine # [ 5.973568] loop: module loaded784machine # [ 5.832695] systemd-modules-load[283]: Inserted module 'loop'785machine # [ 5.842785] systemd[1]: Mounted FUSE Control File System.786machine # [ 5.845985] systemd[1]: Finished Load Kernel Modules.787machine # [ 5.849223] systemd-oomd[284]: No swap; memory pressure usage will be degraded788machine # [ 5.857934] systemd[1]: Finished Remount Root and Kernel File Systems.789machine # [ 5.858907] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.790machine # [ 5.876167] systemd[1]: Listening on Disk Image Download Service Socket.791machine # [ 5.880097] systemd[1]: Starting Firewall...792machine # [ 5.883153] systemd[1]: Starting Flush Journal to Persistent Storage...793machine # [ 5.884203] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore794machine # [ 5.894132] systemd[1]: Starting Load/Save OS Random Seed...795machine # [ 5.902789] systemd[1]: Starting Apply Kernel Variables...796machine # [ 5.903643] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os797machine # [ 6.092304] systemd-journald[282]: Received client request to flush runtime journal.798machine # [ 6.049344] systemd[1]: Mounted Kernel Configuration File System.799machine # [ 6.050549] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.800machine # [ 6.053216] systemd[1]: Finished Load/Save OS Random Seed.801machine # [ 6.054671] systemd[1]: Reached target First Boot Complete.802machine # [ 6.056421] systemd[1]: Starting Create Static Device Nodes in /dev...803machine # [ 6.057442] systemd[1]: Finished Flush Journal to Persistent Storage.804machine # [ 6.073141] systemd[1]: Finished Apply Kernel Variables.805machine # [ 6.160285] systemd[1]: Finished Coldplug All udev Devices.806machine # [ 6.168153] systemd[1]: Finished Create Static Device Nodes in /dev.807machine # [ 6.169269] systemd[1]: Reached target Preparation for Local File Systems.808machine # [ 6.171498] systemd[1]: Starting Rule-based Manager for Device Events and Files...809machine # [ 6.215833] systemd-udevd[318]: Using default interface naming scheme 'v261'.810machine # [ 6.258085] systemd[1]: Started Rule-based Manager for Device Events and Files.811machine # [ 6.373846] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse812machine # [ 6.454106] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.813machine # [ 6.471209] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.814machine # [ 6.503963] (udev-worker)[347]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.815machine # [ 6.507079] (udev-worker)[347]: Network interface NamePolicy= disabled on kernel command line.816machine # [ 6.558349] systemd[1]: Mounting /run/wrappers...817machine # [ 6.599136] systemd[1]: Mounted /run/wrappers.818machine # [ 6.599916] systemd[1]: Reached target Local File Systems.819machine # [ 6.604075] systemd[1]: Listening on Boot Loader Control Service Socket.820machine # [ 6.608552] systemd[1]: Starting Create SUID/SGID Wrappers...821machine # [ 6.609417] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.822machine # [ 6.613928] systemd[1]: Starting Save Transient machine-id to Disk...823machine # [ 6.620793] systemd[1]: Starting Create System Files and Directories...824machine # [ 6.669127] systemd[1]: Condition check resulted in Virtio network device being skipped.825machine # [ 6.672157] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore826machine # [ 6.674729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.827machine # [ 6.676612] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67828machine # [ 6.678962] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore829machine # [ 6.680751] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os830machine # [ 6.683586] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os831machine # [ 6.747958] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.832machine # [ 6.755118] systemd[1]: Finished Save Transient machine-id to Disk.833machine # [ 6.778160] systemd[1]: Finished Create System Files and Directories.834machine # [ 6.786585] systemd[1]: Starting Rebuild Journal Catalog...835machine # [ 6.790382] systemd[1]: Starting Record System Boot/Shutdown in UTMP...836machine # [ 6.863943] systemd[1]: Finished Record System Boot/Shutdown in UTMP.837machine # [ 7.029579] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3838machine # [ 6.889074] systemd[1]: Finished Rebuild Journal Catalog.839machine # [ 6.891507] systemd[1]: Starting Update is Completed...840machine # [ 6.938364] systemd[1]: Finished Update is Completed.841machine # [ 7.089504] ACPI: button: Power Button [PWRF]842machine # [ 7.115867] mousedev: PS/2 mouse device common for all mice843machine # [ 7.171755] rtc_cmos PNP0B00:00: RTC can wake from S4844machine # [ 7.192908] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console845machine # [ 7.203194] rtc_cmos PNP0B00:00: registered as rtc0846machine # [ 7.216783] rtc_cmos PNP0B00:00: setting system clock to 2026-09-29T03:55:35 UTC (1790654135)847machine # [ 7.218535] systemd-journald[282]: Time jumped backwards, rotating.848machine # [ 7.125328] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.849machine # [ 7.126513] systemd[1]: Finished Create SUID/SGID Wrappers.850machine # [ 7.131291] systemd[1]: Reached target System Initialization.851machine # [ 7.132464] systemd[1]: Started Discard unused filesystem blocks once a week.852machine # [ 7.135487] systemd[1]: Started Daily Cleanup of Temporary Directories.853machine # [ 7.139388] systemd[1]: Reached target Timer Units.854machine # [ 7.143072] systemd[1]: Listening on D-Bus System Message Bus Socket.855machine # [ 7.143986] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.856machine # [ 7.145266] systemd[1]: Reached target Socket Units.857machine # [ 7.145986] systemd[1]: Reached target Basic System.858machine # [ 7.146777] systemd[1]: Started backdoor.service.859machine # [ 7.159242] systemd[1]: Starting Import lastlog data into lastlog2 database...860machine # [ 7.161146] systemd[1]: Starting Name Service Cache Daemon (nsncd)...861machine # [ 7.164103] systemd[1]: Starting Post-Boot Actions...862machine # [ 7.178295] systemd[1]: Started Reset console on configuration changes.863machine # [ 7.189108] systemd[1]: Starting resolvconf update...864machine # [ 7.195288] systemd[1]: Finished Firewall.865machine # [ 7.228704] systemd[1]: Starting D-Bus System Message Bus...866machine # [ 7.259141] systemd[1]: Finished Post-Boot Actions.867machine # [ 7.279631] nsncd[491]: Sep 29 03:55:35.705 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"868machine # [ 7.284312] systemd[1]: Started Name Service Cache Daemon (nsncd).869machine # [ 7.285227] systemd[1]: Reached target Host and Network Name Lookups.870machine # [ 7.286190] systemd[1]: Reached target User and Group Name Lookups.871machine # connecting to host...872machine # [ 7.305555] systemd[1]: Starting User Login Management...873machine # [ 7.243438] parport_pc 00:02: reported by Plug and Play ACPI874machine: Guest shell says: b'Spawning backdoor root shell...\n'875machine: connected to guest root shell876machine # [ 7.337146] systemd[1]: Finished Import lastlog data into lastlog2 database.877machine: (connecting took 8.02 seconds)878machine: (finished: waiting for the VM to finish booting, in 8.27 seconds)879machine # [ 7.406873] dbus-broker-launch[498]: Looking up NSS user entry for 'systemd-timesync'...880machine # [ 7.243535] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]881machine # [ 7.251205] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4882machine # [ 7.251339] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized883machine # [ 7.418070] dbus-broker-launch[498]: NSS returned no entry for 'systemd-timesync'884machine # [ 7.419050] dbus-broker-launch[498]: Invalid user-name in /nix/store/dg4f1za18jnbckks03pxvgxlmq0df5bd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"885machine # [ 7.251735] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs886machine # [ 7.463761] Console: switching to colour dummy device 80x25887machine # [ 7.536585] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt888machine # [ 7.536691] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD889machine # [ 7.634422] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6890machine # [ 7.634658] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5891machine # [ 7.658557] [drm] Found bochs VGA, ID 0xb0c5.892machine # [ 7.658559] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.893machine # [ 7.484708] dbus-broker-launch[498]: Ready894machine # [ 7.517842] systemd-logind[516]: New seat seat0.895machine # [ 7.668093] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic896machine # [ 7.668765] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0897machine # [ 7.545625] systemd[1]: Started D-Bus System Message Bus.898machine # [ 7.548461] systemd[1]: Started User Login Management.899machine # [ 7.559909] systemd-logind[516]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)900machine # [ 7.576317] systemd[1]: Stopped target Host and Network Name Lookups.901machine # [ 7.577238] systemd[1]: Stopping Host and Network Name Lookups...902machine # [ 7.578114] systemd[1]: Stopped target User and Group Name Lookups.903machine # [ 7.578990] systemd[1]: Stopping User and Group Name Lookups...904machine # [ 7.587097] systemd[1]: Starting linger-users.service...905machine # [ 7.588973] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...906machine # [ 7.592969] systemd[1]: Starting Virtual Console Setup...907machine # [ 7.598968] systemd[1]: nscd.service: Deactivated successfully.908machine # [ 7.602652] systemd[1]: Stopped Name Service Cache Daemon (nsncd).909machine # [ 7.605077] systemd-logind[516]: Watching system buttons on /dev/input/event2 (Power Button)910machine # [ 7.661593] systemd[1]: Starting Name Service Cache Daemon (nsncd)...911machine # [ 7.892272] Console: switching to colour frame buffer device 160x50912machine # [ 7.919476] ppdev: user-space parallel port driver913machine # [ 7.933887] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)914machine # [ 7.960899] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)915machine # [ 7.966257] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device916machine # [ 7.703323] systemd[1]: Finished resolvconf update.917machine # [ 7.849792] nsncd[588]: Sep 29 03:55:36.152 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"918machine # [ 7.863091] systemd[1]: Reached target Preparation for Network.919machine # [ 7.869151] systemd[1]: Starting DHCP Client...920machine # [ 7.878873] systemd[1]: Starting Address configuration of eth1...921machine # [ 7.893231] systemd[1]: Starting Extra networking commands....922machine # [ 7.904954] systemd[1]: Started Name Service Cache Daemon (nsncd).923machine # [ 7.905923] systemd[1]: Created slice Slice /user/1001.924machine # [ 7.908104] systemd[1]: Reached target Host and Network Name Lookups.925machine # [ 7.908948] systemd[1]: Reached target User and Group Name Lookups.926machine # [ 7.917127] systemd[1]: Starting User Runtime Directory /run/user/1001...927machine # [ 7.918352] systemd[1]: linger-users.service: Deactivated successfully.928machine # [ 7.919385] systemd[1]: Finished linger-users.service.929machine # [ 7.926731] systemd-logind[516]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)930machine # [ 7.928221] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.931machine # [ 7.932125] systemd[1]: Stopped Virtual Console Setup.932machine # [ 7.932870] systemd[1]: Starting Virtual Console Setup...933machine # [ 7.941195] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.934machine # [ 7.942295] systemd[1]: Stopped Virtual Console Setup.935machine # [ 7.947507] systemd[1]: Starting Virtual Console Setup...936machine # [ 7.969118] systemd[1]: Finished User Runtime Directory /run/user/1001.937machine # [ 7.974858] systemd[1]: Starting User Manager for UID 1001...938machine # [ 8.012309] network-addresses-eth1-start[596]: adding address 192.168.1.1/24... done939machine # [ 8.024484] (systemd)[625]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)940machine # [ 8.037153] systemd-logind[516]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.941machine # [ 8.042651] network-addresses-eth1-start[596]: adding address 2001:db8:1::1/64... done942machine # [ 8.070966] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy943machine # [ 8.146571] systemd[1]: Finished Address configuration of eth1.944machine # [ 8.391348] kvm_amd: TSC scaling supported945machine # [ 8.391934] kvm_amd: Nested Virtualization enabled946machine # [ 8.395560] kvm_amd: Nested Paging enabled947machine # [ 8.396032] kvm_amd: LBR virtualization supported948machine # [ 8.398943] kvm_amd: Virtual VMLOAD VMSAVE supported949machine # [ 8.399461] kvm_amd: Virtual GIF supported950machine # [ 8.399856] kvm_amd: Virtual NMI enabled951machine # [ 8.277890] systemd[1]: Finished Extra networking commands..952machine # [ 8.278788] systemd[1]: Reached target Network.953machine # [ 8.281454] systemd[1]: Starting Permit User Sessions...954machine # [ 8.287835] dhcpcd[629]: dhcpcd-10.3.2 starting955machine # [ 8.296945] systemd[625]: Queued start job for default target Main User Target.956machine # [ 8.299264] dhcpcd[690]: dev: loaded udev957machine # [ 8.304205] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy958machine # [ 8.306695] systemd[625]: Created slice User Application Slice.959machine # [ 8.307546] systemd[625]: Started Daily Cleanup of User's Temporary Directories.960machine # [ 8.310359] systemd[625]: Reached target Paths.961machine # [ 8.311494] systemd[625]: Reached target Timers.962machine # [ 8.315130] systemd[625]: Starting D-Bus User Message Bus Socket...963machine # [ 8.316025] systemd[625]: Starting Create User Files and Directories...964machine # [ 8.469619] EDAC MC: Ver: 3.0.0965machine # [ 8.482756] 8021q: 802.1Q VLAN Support v1.8966machine # [ 8.483219] 8021q: adding VLAN 0 to HW filter on device eth1967machine # [ 8.381483] systemd[625]: Finished Create User Files and Directories.968machine # [ 8.382405] systemd[1]: Finished Permit User Sessions.969machine # [ 8.385416] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.970machine # [ 8.391769] systemd[1]: Started Getty on tty1.971machine # [ 8.393258] systemd[1]: Reached target Login Prompts.972machine # [ 8.439982] systemd[625]: Listening on D-Bus User Message Bus Socket.973machine # [ 8.440930] systemd[625]: Reached target Sockets.974machine # [ 8.441625] systemd[625]: Reached target Basic System.975machine # [ 8.442892] systemd[1]: Started User Manager for UID 1001.976machine # [ 8.444591] systemd[625]: Starting Run user-specific NixOS activation...977machine # [ 8.608246] cfg80211: Loading compiled-in X.509 certificates for regulatory database978machine # [ 8.489590] systemd[625]: Finished Run user-specific NixOS activation.979machine # [ 8.490833] systemd[625]: Reached target Main User Target.980machine # [ 8.492378] systemd[625]: Startup finished in 437ms.981machine # [ 8.636960] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'982machine # [ 8.637633] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'983machine # [ 8.639709] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2984machine # [ 8.640548] cfg80211: failed to load regulatory.db985machine # [ 8.667794] 8021q: adding VLAN 0 to HW filter on device eth0986machine # [ 8.525956] dhcpcd[690]: eth0: waiting for carrier987machine # [ 8.526887] dhcpcd[690]: libudev: received NULL device988machine # [ 8.528611] dhcpcd[690]: libudev: received NULL device989machine # [ 8.529873] dhcpcd[690]: eth0: carrier acquired990machine # [ 8.534174] dhcpcd[690]: DUID 00:01:00:01:32:4d:f3:38:52:54:00:12:34:56991machine # [ 8.535399] dhcpcd[690]: eth0: IAID 00:12:34:56992machine # [ 8.536115] dhcpcd[690]: eth0: adding address fe80::5054:ff:fe12:3456993machine # [ 8.569153] systemd-vconsole-setup[622]: Configuration of first virtual console was skipped, ignoring remaining ones.994machine # [ 8.572137] systemd[1]: Finished Virtual Console Setup.995machine # [ 8.675866] dhcpcd[690]: eth0: soliciting a DHCP lease996machine # [ 8.839156] NET: Registered PF_PACKET protocol family997machine # [ 8.702719] dhcpcd[690]: eth0: offered 10.0.2.15 from 10.0.2.2998machine # [ 8.705165] dhcpcd[690]: eth0: probing address 10.0.2.15/24999machine # [ 11.143590] dhcpcd[690]: eth0: soliciting an IPv6 router1000machine # [ 11.146476] dhcpcd[690]: eth0: Router Advertisement from fe80::21001machine # [ 11.148614] dhcpcd[690]: eth0: adding address fec0::5054:ff:fe12:3456/641002machine # [ 11.150833] dhcpcd[690]: eth0: adding route to fec0::/641003machine # [ 11.152758] dhcpcd[690]: eth0: adding default route via fe80::21004machine # [ 13.829531] dhcpcd[690]: eth0: leased 10.0.2.15 for 86400 seconds1005machine # [ 13.831110] dhcpcd[690]: eth0: adding route to 10.0.2.0/241006machine # [ 13.831907] dhcpcd[690]: eth0: adding default route via 10.0.2.21007machine # [ 13.890595] systemd[1]: Started DHCP Client.1008machine # [ 13.892615] systemd[1]: Reached target Multi-User System.1009machine # [ 13.893576] systemd[1]: Startup finished in 880ms (kernel) + 4.077s (initrd) + 8.933s (userspace) = 13.892s.1010machine: (finished: waiting for unit multi-user.target, in 14.95 seconds)1011machine: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test1012machine # Checking switch inhibitors... done1013machine # [ 14.225500] nixos[829]: switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1014machine # [ 14.227681] systemd[1]: Stopped target Local File Systems.1015machine # [ 14.229238] systemd[1]: Stopped target Remote File Systems.1016machine # activating the configuration...1017machine # setting up /etc...1018machine # [ 14.449422] systemd[1]: Reload requested from client PID 829 ('.switch-to-conf') (unit backdoor.service)...1019machine # [ 14.451171] systemd[1]: Reloading...1020machine # [ 14.813079] systemd[1]: Reloading finished in 360 ms.1021machine # reloading user units for usertest...1022machine # [ 14.841295] systemd[625]: Created slice User Core Session Slice.1023machine # [ 14.843596] systemd[625]: Starting D-Bus User Message Bus...1024machine # [ 14.864989] dbus-broker-launch[899]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/dg4f1za18jnbckks03pxvgxlmq0df5bd-system-path/share/dbus-1/services/org.freedesktop.import1.service'1025machine # [ 14.867650] dbus-broker-launch[899]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/dg4f1za18jnbckks03pxvgxlmq0df5bd-system-path/share/dbus-1/services/org.freedesktop.machine1.service'1026machine # [ 14.870243] dbus-broker-launch[899]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/dg4f1za18jnbckks03pxvgxlmq0df5bd-system-path/share/dbus-1/services/org.freedesktop.portable1.service'1027machine # [ 14.874721] dbus-broker-launch[899]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/dg4f1za18jnbckks03pxvgxlmq0df5bd-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'1028machine # [ 14.877634] dbus-broker-launch[899]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored1029machine # [ 14.880165] dbus-broker-launch[899]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored1030machine # [ 14.882158] systemd[625]: Started D-Bus User Message Bus.1031machine # [ 14.885582] dbus-broker-launch[899]: Ready1032machine # [ 14.940876] systemd[625]: Reexecution requested from client PID 898 ('switch-to-confi')...1033machine # [ 14.942153] systemd[625]: Reexecuting.1034machine # [ 14.962450] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1035machine # [ 15.033279] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1036machine # [ 15.038372] systemd[625]: Reload requested from client PID 898 ('switch-to-confi')...1037machine # [ 15.040184] systemd[625]: Reloading...1038machine # [ 15.111965] systemd[625]: Reloading finished in 70 ms.1039machine # [ 15.115818] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1040machine # restarting the following user units: nixos-activation.service1041machine # [ 15.122542] systemd[625]: Stopped Run user-specific NixOS activation.1042machine # [ 15.124057] systemd[625]: Stopping Run user-specific NixOS activation...1043machine # [ 15.126148] systemd[625]: Starting Run user-specific NixOS activation...1044machine # [ 15.145302] systemd[625]: Finished Run user-specific NixOS activation.1045machine # restarting sysinit-reactivation.target1046machine # [ 15.153923] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....1047machine # [ 15.219166] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..1048machine # [ 15.222760] systemd[1]: Reached target Reactivate sysinit units.1049machine # [ 15.228398] systemd[1]: Reached target Remote File Systems.1050machine # [ 15.230940] systemd[1]: Starting linger-users.service...1051machine # [ 15.233427] systemd[1]: Reached target Local File Systems.1052machine # [ 15.238492] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1053machine # [ 15.241503] systemd[1]: Starting Create SUID/SGID Wrappers...1054machine # [ 15.242322] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1055machine # [ 15.243503] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671056machine # [ 15.245510] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1057machine # [ 15.246959] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1058machine # [ 15.249519] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1059machine # [ 15.255260] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1060machine # [ 15.256705] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1061machine # [ 15.293687] systemd[1]: linger-users.service: Deactivated successfully.1062machine # [ 15.295475] systemd[1]: Finished linger-users.service.1063machine # [ 15.408329] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1064machine # [ 15.409943] systemd[1]: Finished Create SUID/SGID Wrappers.1065machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service1066machine # [ 15.670991] nixos[829]: finished switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1067machine: (finished: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test, in 1.66 seconds)1068machine: must succeed: rm /etc/NIXOS1069machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds)1070machine: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/bin/switch-to-configuration test1071machine # this should succeed (config: /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test, action: test)1072machine # Checking switch inhibitors... done1073machine # [ 15.922378] nixos[977]: switching to system configuration /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test1074machine # activating the configuration...1075machine # [ 15.926349] systemd[1]: Stopped target Local File Systems.1076machine # [ 15.927348] systemd[1]: Stopped target Remote File Systems.1077machine # removing user ‘usertest’1078machine # setting up /etc...1079machine # [ 16.155410] systemd[1]: Reload requested from client PID 977 ('.switch-to-conf') (unit backdoor.service)...1080machine # [ 16.158906] systemd[1]: Reloading...1081machine # [ 16.399665] systemd[1]: Reloading finished in 242 ms.1082machine # reloading user units for usertest...1083machine # [ 16.461517] systemd[625]: Reexecution requested from client PID 1048 ('switch-to-confi')...1084machine # [ 16.463386] systemd[625]: Reexecuting.1085machine # [ 16.482863] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1086machine # [ 16.554069] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1087machine # [ 16.560750] systemd[625]: Reload requested from client PID 1048 ('switch-to-confi')...1088machine # [ 16.562297] systemd[625]: Reloading...1089machine # [ 16.630772] systemd[625]: Reloading finished in 67 ms.1090machine # [ 16.635819] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1091machine # restarting the following user units: nixos-activation.service1092machine # [ 16.643140] systemd[625]: Stopped Run user-specific NixOS activation.1093machine # [ 16.644242] systemd[625]: Stopping Run user-specific NixOS activation...1094machine # [ 16.646824] systemd[625]: Starting Run user-specific NixOS activation...1095machine # [ 16.667547] systemd[625]: Finished Run user-specific NixOS activation.1096machine # restarting sysinit-reactivation.target1097machine # [ 16.671548] systemd[1]: Stopped target Reactivate sysinit units.1098machine # [ 16.673236] systemd[1]: Stopping Reactivate sysinit units...1099machine # [ 16.674365] systemd[1]: Reached target Reactivate sysinit units.1100machine # reloading the following units: dbus-broker.service1101machine # [ 16.677736] dbus-broker-launch[498]: Caught SIGHUP, trigger reload.1102machine # [ 16.679204] systemd[1]: Reloading D-Bus System Message Bus...1103machine # [ 16.684809] dbus-broker-launch[498]: Looking up NSS user entry for 'systemd-timesync'...1104machine # [ 16.686849] dbus-broker-launch[498]: NSS returned no entry for 'systemd-timesync'1105machine # [ 16.687970] dbus-broker-launch[498]: Invalid user-name in /nix/store/klcbixngds5zzrfg5s4jxjm8167b05x6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1106machine # [ 16.699024] systemd[1]: Reloaded D-Bus System Message Bus.1107machine # restarting the following units: network-addresses-eth1.service1108machine # [ 16.704114] systemd[1]: Stopping Address configuration of eth1...1109machine # [ 16.725556] network-addresses-eth1-pre-stop[1060]: deleting address 192.168.1.1/24... done1110machine # [ 16.731474] network-addresses-eth1-pre-stop[1060]: deleting address 2001:db8:1::1/64... done1111machine # [ 16.737048] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1112machine # [ 16.738767] systemd[1]: Stopped Address configuration of eth1.1113machine # [ 16.742262] systemd[1]: Starting Address configuration of eth1...1114machine # [ 16.771372] network-addresses-eth1-start[1065]: adding address 192.168.1.2/24... done1115machine # [ 16.777436] network-addresses-eth1-start[1065]: adding address 2001:db8:1::2/64... done1116machine # [ 16.785065] systemd[1]: Finished Address configuration of eth1.1117machine # [ 16.791067] systemd[1]: Reached target Local File Systems.1118machine # [ 16.794690] systemd[1]: Reached target Remote File Systems.1119machine # [ 16.797640] systemd[1]: Starting linger-users.service...1120machine # [ 16.799708] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1121machine # [ 16.801336] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1122machine # [ 16.804979] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1123machine # [ 16.809826] systemd[1]: Starting Create SUID/SGID Wrappers...1124machine # [ 16.810647] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1125machine # [ 16.811815] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671126machine # [ 16.813740] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1127machine # [ 16.815206] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1128machine # [ 16.821189] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1129machine # [ 16.849530] linger-users-start[1080]: id: ‘usertest’: no such user1130machine # [ 16.851558] linger-users-start[1076]: Removing linger for missing user usertest1131machine # [ 16.859226] systemd[1]: linger-users.service: Deactivated successfully.1132machine # [ 16.860329] systemd[1]: Finished linger-users.service.1133machine # [ 16.993784] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1134machine # [ 16.996151] systemd[1]: Finished Create SUID/SGID Wrappers.1135machine # [ 17.253430] nixos[977]: finished switching to system configuration /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test1136machine: (finished: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/bin/switch-to-configuration test, in 1.55 seconds)1137subtest: pre-switch checks1138machine: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/bin/switch-to-configuration check1139machine # this should succeed (config: /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test, action: check)1140machine # Checking switch inhibitors... done1141machine: (finished: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/bin/switch-to-configuration check, in 0.03 seconds)1142machine: must fail: /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&11143machine: (finished: must fail: /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&1, in 0.02 seconds)1144machine: must fail: /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&11145machine: (finished: must fail: /nix/store/jspqb607h4zw5ms3fqf9f90hzm4ra1lq-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&1, in 0.02 seconds)1146(finished: subtest: pre-switch checks, in 0.07 seconds)1147subtest: switch inhibitors1148machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11149machine # [ 17.528580] nixos[1165]: switching to system configuration /nix/store/9kcx1bmxzhw6vlsfay0swwrrw67fxj27-nixos-system-machine-test1150machine # [ 17.530857] systemd[1]: Stopped target Remote File Systems.1151machine # [ 17.532847] systemd[1]: Stopped target Local File Systems.1152machine # [ 17.741546] systemd[1]: Reload requested from client PID 1165 ('.switch-to-conf') (unit backdoor.service)...1153machine # [ 17.743146] systemd[1]: Reloading...1154machine # [ 17.965900] systemd[1]: Reloading finished in 220 ms.1155machine # [ 18.028672] systemd[625]: Reexecution requested from client PID 1235 ('switch-to-confi')...1156machine # [ 18.030617] systemd[625]: Reexecuting.1157machine # [ 18.051039] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1158machine # [ 18.139818] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1159machine # [ 18.145903] systemd[625]: Reload requested from client PID 1235 ('switch-to-confi')...1160machine # [ 18.147908] systemd[625]: Reloading...1161machine # [ 18.218158] systemd[625]: Reloading finished in 70 ms.1162machine # [ 18.223828] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1163machine # [ 18.230796] systemd[625]: Stopped Run user-specific NixOS activation.1164machine # [ 18.231837] systemd[625]: Stopping Run user-specific NixOS activation...1165machine # [ 18.233480] systemd[625]: Starting Run user-specific NixOS activation...1166machine # [ 18.255741] systemd[625]: Finished Run user-specific NixOS activation.1167machine # [ 18.259270] systemd[1]: Stopped target Reactivate sysinit units.1168machine # [ 18.260581] systemd[1]: Stopping Reactivate sysinit units...1169machine # [ 18.261520] systemd[1]: Reached target Reactivate sysinit units.1170machine # [ 18.264198] dbus-broker-launch[498]: Caught SIGHUP, trigger reload.1171machine # [ 18.265894] systemd[1]: Reloading D-Bus System Message Bus...1172machine # [ 18.269298] dbus-broker-launch[498]: Looking up NSS user entry for 'systemd-timesync'...1173machine # [ 18.271071] dbus-broker-launch[498]: NSS returned no entry for 'systemd-timesync'1174machine # [ 18.272058] dbus-broker-launch[498]: Invalid user-name in /nix/store/dg4f1za18jnbckks03pxvgxlmq0df5bd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1175machine # [ 18.281143] systemd[1]: Reloaded D-Bus System Message Bus.1176machine # [ 18.285139] systemd[1]: Stopping Address configuration of eth1...1177machine # [ 18.303439] network-addresses-eth1-pre-stop[1248]: deleting address 192.168.1.2/24... done1178machine # [ 18.308756] network-addresses-eth1-pre-stop[1248]: deleting address 2001:db8:1::2/64... done1179machine # [ 18.313494] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1180machine # [ 18.314988] systemd[1]: Stopped Address configuration of eth1.1181machine # [ 18.318282] systemd[1]: Starting Address configuration of eth1...1182machine # [ 18.343692] network-addresses-eth1-start[1253]: adding address 192.168.1.1/24... done1183machine # [ 18.350382] network-addresses-eth1-start[1253]: adding address 2001:db8:1::1/64... done1184machine # [ 18.357474] systemd[1]: Finished Address configuration of eth1.1185machine # [ 18.364426] systemd[1]: Reached target Local File Systems.1186machine # [ 18.366129] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1187machine # [ 18.372878] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1188machine # [ 18.374985] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1189machine # [ 18.377198] systemd[1]: Starting Create SUID/SGID Wrappers...1190machine # [ 18.377955] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1191machine # [ 18.380119] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671192machine # [ 18.382624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1193machine # [ 18.386353] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1194machine # [ 18.389166] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1195machine # [ 18.390267] systemd[1]: Reached target Remote File Systems.1196machine # [ 18.520792] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1197machine # [ 18.522405] systemd[1]: Finished Create SUID/SGID Wrappers.1198machine # [ 18.526193] systemd[1]: Starting linger-users.service...1199machine # [ 18.546917] systemd[1]: linger-users.service: Deactivated successfully.1200machine # [ 18.548421] systemd[1]: Finished linger-users.service.1201machine # [ 18.806754] nixos[1165]: finished switching to system configuration /nix/store/9kcx1bmxzhw6vlsfay0swwrrw67fxj27-nixos-system-machine-test1202machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 1.48 seconds)1203machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&11204machine # [ 19.016499] nixos[1322]: switching to system configuration /nix/store/hmhfrzif0npsrba4irfvcpxxx6b2g27m-nixos-system-machine-test1205machine # [ 19.018972] systemd[1]: Stopped target Remote File Systems.1206machine # [ 19.020558] systemd[1]: Stopped target Local File Systems.1207machine # [ 19.232981] systemd[1]: Reload requested from client PID 1322 ('.switch-to-conf') (unit backdoor.service)...1208machine # [ 19.234617] systemd[1]: Reloading...1209machine # [ 19.462989] systemd[1]: Reloading finished in 227 ms.1210machine # [ 19.525555] systemd[625]: Reexecution requested from client PID 1392 ('switch-to-confi')...1211machine # [ 19.527050] systemd[625]: Reexecuting.1212machine # [ 19.547144] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1213machine # [ 19.623439] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1214machine # [ 19.628761] systemd[625]: Reload requested from client PID 1392 ('switch-to-confi')...1215machine # [ 19.630792] systemd[625]: Reloading...1216machine # [ 19.703619] systemd[625]: Reloading finished in 73 ms.1217machine # [ 19.709822] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1218machine # [ 19.716737] systemd[625]: Stopped Run user-specific NixOS activation.1219machine # [ 19.717639] systemd[625]: Stopping Run user-specific NixOS activation...1220machine # [ 19.719224] systemd[625]: Starting Run user-specific NixOS activation...1221machine # [ 19.739223] systemd[625]: Finished Run user-specific NixOS activation.1222machine # [ 19.742773] systemd[1]: Stopped target Reactivate sysinit units.1223machine # [ 19.743793] systemd[1]: Stopping Reactivate sysinit units...1224machine # [ 19.744880] systemd[1]: Reached target Reactivate sysinit units.1225machine # [ 19.746746] systemd[1]: Reached target Remote File Systems.1226machine # [ 19.749562] systemd[1]: Starting linger-users.service...1227machine # [ 19.756958] systemd[1]: Reached target Local File Systems.1228machine # [ 19.761128] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1229machine # [ 19.765272] systemd[1]: Starting Create SUID/SGID Wrappers...1230machine # [ 19.766928] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1231machine # [ 19.769116] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671232machine # [ 19.771975] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1233machine # [ 19.775113] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1234machine # [ 19.776344] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1235machine # [ 19.778373] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1236machine # [ 19.780102] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1237machine # [ 19.813610] systemd[1]: linger-users.service: Deactivated successfully.1238machine # [ 19.815821] systemd[1]: Finished linger-users.service.1239machine # [ 19.925124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1240machine # [ 19.927174] systemd[1]: Finished Create SUID/SGID Wrappers.1241machine # [ 20.184747] nixos[1322]: finished switching to system configuration /nix/store/hmhfrzif0npsrba4irfvcpxxx6b2g27m-nixos-system-machine-test1242machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&1, in 1.37 seconds)1243machine: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&11244machine: (finished: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&1, in 0.03 seconds)1245machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&11246machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&1, in 0.02 seconds)1247machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&11248machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&1, in 0.23 seconds)1249machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&11250machine # [ 20.651746] nixos[1487]: switching to system configuration /nix/store/2zjdkspw0y8nb2k0pqk6d3l4pcdxxz50-nixos-system-machine-test1251machine # [ 20.653863] systemd[1]: Stopped target Local File Systems.1252machine # [ 20.655497] systemd[1]: Stopped target Remote File Systems.1253machine # [ 20.860778] systemd[1]: Reload requested from client PID 1487 ('.switch-to-conf') (unit backdoor.service)...1254machine # [ 20.862376] systemd[1]: Reloading...1255machine # [ 21.097972] systemd[1]: Reloading finished in 234 ms.1256machine # [ 21.160098] systemd[625]: Reexecution requested from client PID 1557 ('switch-to-confi')...1257machine # [ 21.162601] systemd[625]: Reexecuting.1258machine # [ 21.184150] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1259machine # [ 21.257089] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1260machine # [ 21.262549] systemd[625]: Reload requested from client PID 1557 ('switch-to-confi')...1261machine # [ 21.263978] systemd[625]: Reloading...1262machine # [ 21.360281] systemd[625]: Reloading finished in 94 ms.1263machine # [ 21.363838] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1264machine # [ 21.370130] systemd[625]: Stopped Run user-specific NixOS activation.1265machine # [ 21.371169] systemd[625]: Stopping Run user-specific NixOS activation...1266machine # [ 21.373548] systemd[625]: Starting Run user-specific NixOS activation...1267machine # [ 21.392432] systemd[625]: Finished Run user-specific NixOS activation.1268machine # [ 21.395389] systemd[1]: Stopped target Reactivate sysinit units.1269machine # [ 21.396667] systemd[1]: Stopping Reactivate sysinit units...1270machine # [ 21.397701] systemd[1]: Reached target Reactivate sysinit units.1271machine # [ 21.402221] systemd[1]: Reached target Remote File Systems.1272machine # [ 21.406833] systemd[1]: Starting linger-users.service...1273machine # [ 21.409059] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1274machine # [ 21.410724] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1275machine # [ 21.415471] systemd[1]: Reached target Local File Systems.1276machine # [ 21.418757] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1277machine # [ 21.423066] systemd[1]: Starting Create SUID/SGID Wrappers...1278machine # [ 21.423876] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1279machine # [ 21.425677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671280machine # [ 21.427599] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1281machine # [ 21.430883] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1282machine # [ 21.433128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1283machine # [ 21.465489] systemd[1]: linger-users.service: Deactivated successfully.1284machine # [ 21.467720] systemd[1]: Finished linger-users.service.1285machine # [ 21.576083] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1286machine # [ 21.577817] systemd[1]: Finished Create SUID/SGID Wrappers.1287machine # [ 21.835457] nixos[1487]: finished switching to system configuration /nix/store/2zjdkspw0y8nb2k0pqk6d3l4pcdxxz50-nixos-system-machine-test1288machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&1, in 1.38 seconds)1289machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11290machine # [ 22.044823] nixos[1629]: switching to system configuration /nix/store/9kcx1bmxzhw6vlsfay0swwrrw67fxj27-nixos-system-machine-test1291machine # [ 22.047625] systemd[1]: Stopped target Remote File Systems.1292machine # [ 22.049211] systemd[1]: Stopped target Local File Systems.1293machine # [ 22.250237] systemd[1]: Reload requested from client PID 1629 ('.switch-to-conf') (unit backdoor.service)...1294machine # [ 22.251949] systemd[1]: Reloading...1295machine # [ 22.477567] systemd[1]: Reloading finished in 224 ms.1296machine # [ 22.537983] systemd[625]: Reexecution requested from client PID 1699 ('switch-to-confi')...1297machine # [ 22.540354] systemd[625]: Reexecuting.1298machine # [ 22.559961] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1299machine # [ 22.630843] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1300machine # [ 22.635882] systemd[625]: Reload requested from client PID 1699 ('switch-to-confi')...1301machine # [ 22.637391] systemd[625]: Reloading...1302machine # [ 22.708258] systemd[625]: Reloading finished in 69 ms.1303machine # [ 22.713828] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1304machine # [ 22.720127] systemd[625]: Stopped Run user-specific NixOS activation.1305machine # [ 22.721086] systemd[625]: Stopping Run user-specific NixOS activation...1306machine # [ 22.723642] systemd[625]: Starting Run user-specific NixOS activation...1307machine # [ 22.742102] systemd[625]: Finished Run user-specific NixOS activation.1308machine # [ 22.744964] systemd[1]: Stopped target Reactivate sysinit units.1309machine # [ 22.746255] systemd[1]: Stopping Reactivate sysinit units...1310machine # [ 22.747311] systemd[1]: Reached target Reactivate sysinit units.1311machine # [ 22.748742] systemd[1]: Reached target Remote File Systems.1312machine # [ 22.755473] systemd[1]: Reached target Local File Systems.1313machine # [ 22.757425] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1314machine # [ 22.758666] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1315machine # [ 22.760570] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1316machine # [ 22.763495] systemd[1]: Starting Create SUID/SGID Wrappers...1317machine # [ 22.765462] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1318machine # [ 22.766645] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671319machine # [ 22.769225] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1320machine # [ 22.770698] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1321machine # [ 22.773121] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1322machine # [ 22.898226] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1323machine # [ 22.899795] systemd[1]: Finished Create SUID/SGID Wrappers.1324machine # [ 22.903694] systemd[1]: Starting linger-users.service...1325machine # [ 22.929379] systemd[1]: linger-users.service: Deactivated successfully.1326machine # [ 22.930864] systemd[1]: Finished linger-users.service.1327machine # [ 23.188141] nixos[1629]: finished switching to system configuration /nix/store/9kcx1bmxzhw6vlsfay0swwrrw67fxj27-nixos-system-machine-test1328machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 1.35 seconds)1329(finished: subtest: switch inhibitors, in 5.86 seconds)1330subtest: actions1331machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&11332machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&1, in 0.05 seconds)1333machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration switch 2>&11334machine # [ 23.423368] nixos[1777]: switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1335machine # [ 23.426610] systemd[1]: Stopped target Remote File Systems.1336machine # [ 23.427631] systemd[1]: Stopped target Local File Systems.1337machine # [ 23.632424] systemd[1]: Reload requested from client PID 1777 ('.switch-to-conf') (unit backdoor.service)...1338machine # [ 23.634104] systemd[1]: Reloading...1339machine # [ 23.866697] systemd[1]: Reloading finished in 230 ms.1340machine # [ 23.928315] systemd[625]: Reexecution requested from client PID 1847 ('switch-to-confi')...1341machine # [ 23.929553] systemd[625]: Reexecuting.1342machine # [ 23.948958] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1343machine # [ 24.019757] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1344machine # [ 24.024787] systemd[625]: Reload requested from client PID 1847 ('switch-to-confi')...1345machine # [ 24.026063] systemd[625]: Reloading...1346machine # [ 24.097440] systemd[625]: Reloading finished in 69 ms.1347machine # [ 24.102830] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1348machine # [ 24.108825] systemd[625]: Stopped Run user-specific NixOS activation.1349machine # [ 24.110303] systemd[625]: Stopping Run user-specific NixOS activation...1350machine # [ 24.112178] systemd[625]: Starting Run user-specific NixOS activation...1351machine # [ 24.132763] systemd[625]: Finished Run user-specific NixOS activation.1352machine # [ 24.135752] systemd[1]: Stopped target Reactivate sysinit units.1353machine # [ 24.137279] systemd[1]: Stopping Reactivate sysinit units...1354machine # [ 24.138471] systemd[1]: Reached target Reactivate sysinit units.1355machine # [ 24.140939] systemd[1]: Reached target Local File Systems.1356machine # [ 24.143543] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1357machine # [ 24.145238] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1358machine # [ 24.147322] systemd[1]: Reached target Remote File Systems.1359machine # [ 24.154732] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1360machine # [ 24.156920] systemd[1]: Starting Create SUID/SGID Wrappers...1361machine # [ 24.158308] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1362machine # [ 24.161247] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671363machine # [ 24.163775] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1364machine # [ 24.165221] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1365machine # [ 24.166381] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1366machine # [ 24.292759] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1367machine # [ 24.294438] systemd[1]: Finished Create SUID/SGID Wrappers.1368machine # [ 24.297921] systemd[1]: Starting linger-users.service...1369machine # [ 24.325456] systemd[1]: linger-users.service: Deactivated successfully.1370machine # [ 24.327646] systemd[1]: Finished linger-users.service.1371machine # [ 24.582947] nixos[1777]: finished switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1372machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration switch 2>&1, in 1.35 seconds)1373machine: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&11374machine: (finished: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&1, in 0.03 seconds)1375machine: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration 2>&11376machine: (finished: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration 2>&1, in 0.02 seconds)1377(finished: subtest: actions, in 1.45 seconds)1378subtest: init interface version1379machine: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&11380machine: (finished: must fail: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&1, in 0.02 seconds)1381(finished: subtest: init interface version, in 0.02 seconds)1382subtest: systemd restarts1383machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11384machine # [ 24.840364] nixos[1934]: switching to system configuration /nix/store/frc10wr71dvii9gaas36jp21vqrqvk4f-nixos-system-machine-test1385machine # [ 24.842706] systemd[1]: Stopped target Local File Systems.1386machine # [ 24.844676] systemd[1]: Stopped target Remote File Systems.1387machine # [ 25.064391] systemd[1]: Reexecution requested from client PID 1934 ('.switch-to-conf') (unit backdoor.service)...1388machine # [ 25.068691] systemd[1]: Reexecuting.1389machine # [ 25.353682] systemd[1]: systemd 263-583679f 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)1390machine # [ 25.362193] systemd[1]: Detected virtualization kvm.1391machine # [ 25.363734] systemd[1]: Detected architecture x86-64.1392machine # [ 25.455205] systemd[1]: bpf-restrict-fs: LSM BPF program attached1393machine # [ 25.525740] systemd[1]: Reload requested from client PID 1934 ('.switch-to-conf') (unit backdoor.service)...1394machine # [ 25.527415] systemd[1]: Reloading...1395machine # [ 25.756889] systemd[1]: Reloading finished in 228 ms.1396machine # [ 25.817848] systemd[625]: Reexecution requested from client PID 2037 ('switch-to-confi')...1397machine # [ 25.820311] systemd[625]: Reexecuting.1398machine # [ 25.841434] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 25.918386] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1400machine # [ 25.923410] systemd[625]: Reload requested from client PID 2037 ('switch-to-confi')...1401machine # [ 25.925054] systemd[625]: Reloading...1402machine # [ 25.994550] systemd[625]: Reloading finished in 68 ms.1403machine # [ 25.999822] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1404machine # [ 26.005963] systemd[625]: Stopped Run user-specific NixOS activation.1405machine # [ 26.006940] systemd[625]: Stopping Run user-specific NixOS activation...1406machine # [ 26.009230] systemd[625]: Starting Run user-specific NixOS activation...1407machine # [ 26.028397] systemd[625]: Finished Run user-specific NixOS activation.1408machine # [ 26.031685] systemd[1]: Stopped target Reactivate sysinit units.1409machine # [ 26.033357] systemd[1]: Stopping Reactivate sysinit units...1410machine # [ 26.034505] systemd[1]: Reached target Reactivate sysinit units.1411machine # [ 26.036288] systemd[1]: Reached target Remote File Systems.1412machine # [ 26.039483] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1413machine # [ 26.041107] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1414machine # [ 26.045180] systemd[1]: Starting linger-users.service...1415machine # [ 26.052164] systemd[1]: Reached target Local File Systems.1416machine # [ 26.052971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1417machine # [ 26.057052] systemd[1]: Starting Create SUID/SGID Wrappers...1418machine # [ 26.057878] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1419machine # [ 26.060156] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671420machine # [ 26.062871] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1421machine # [ 26.065218] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1422machine # [ 26.067881] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1423machine # [ 26.102813] systemd[1]: linger-users.service: Deactivated successfully.1424machine # [ 26.105586] systemd[1]: Finished linger-users.service.1425machine # [ 26.201360] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1426machine # [ 26.202989] systemd[1]: Finished Create SUID/SGID Wrappers.1427machine # [ 26.460798] nixos[1934]: finished switching to system configuration /nix/store/frc10wr71dvii9gaas36jp21vqrqvk4f-nixos-system-machine-test1428machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1429(finished: subtest: systemd restarts, in 1.80 seconds)1430subtest: continuing from an aborted switch1431machine: must succeed: echo dbus-broker.service > /run/nixos/start-list1432machine: (finished: must succeed: echo dbus-broker.service > /run/nixos/start-list, in 0.01 seconds)1433machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11434machine # [ 26.662614] nixos[2111]: switching to system configuration /nix/store/frc10wr71dvii9gaas36jp21vqrqvk4f-nixos-system-machine-test1435machine # [ 26.664822] systemd[1]: Stopped target Remote File Systems.1436machine # [ 26.666464] systemd[1]: Stopped target Local File Systems.1437machine # [ 26.871083] systemd[1]: Reload requested from client PID 2111 ('.switch-to-conf') (unit backdoor.service)...1438machine # [ 26.872941] systemd[1]: Reloading...1439machine # [ 27.109357] systemd[1]: Reloading finished in 235 ms.1440machine # [ 27.172493] systemd[625]: Reexecution requested from client PID 2180 ('switch-to-confi')...1441machine # [ 27.173870] systemd[625]: Reexecuting.1442machine # [ 27.195219] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1443machine # [ 27.272032] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1444machine # [ 27.277563] systemd[625]: Reload requested from client PID 2180 ('switch-to-confi')...1445machine # [ 27.278885] systemd[625]: Reloading...1446machine # [ 27.356718] systemd[625]: Reloading finished in 76 ms.1447machine # [ 27.361893] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1448machine # [ 27.368617] systemd[625]: Stopped Run user-specific NixOS activation.1449machine # [ 27.370125] systemd[625]: Stopping Run user-specific NixOS activation...1450machine # [ 27.372208] systemd[625]: Starting Run user-specific NixOS activation...1451machine # [ 27.394544] systemd[625]: Finished Run user-specific NixOS activation.1452machine # [ 27.397861] systemd[1]: Stopped target Reactivate sysinit units.1453machine # [ 27.399184] systemd[1]: Stopping Reactivate sysinit units...1454machine # [ 27.399958] systemd[1]: Reached target Reactivate sysinit units.1455machine # [ 27.404325] systemd[1]: Reached target Remote File Systems.1456machine # [ 27.413786] systemd[1]: Starting linger-users.service...1457machine # [ 27.415300] systemd[1]: Reached target Local File Systems.1458machine # [ 27.419261] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1459machine # [ 27.420492] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1460machine # [ 27.425324] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1461machine # [ 27.430288] systemd[1]: Starting Create SUID/SGID Wrappers...1462machine # [ 27.431152] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1463machine # [ 27.432261] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671464machine # [ 27.434146] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1465machine # [ 27.435550] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1466machine # [ 27.436712] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1467machine # [ 27.477711] systemd[1]: linger-users.service: Deactivated successfully.1468machine # [ 27.480110] systemd[1]: Finished linger-users.service.1469machine # [ 27.594444] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1470machine # [ 27.596315] systemd[1]: Finished Create SUID/SGID Wrappers.1471machine # [ 27.854868] nixos[2111]: finished switching to system configuration /nix/store/frc10wr71dvii9gaas36jp21vqrqvk4f-nixos-system-machine-test1472machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 1.38 seconds)1473(finished: subtest: continuing from an aborted switch, in 1.40 seconds)1474subtest: aborts on already locked lock file1475??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1476 File "/nix/store/vk7cx7y36sxavc4g6cv4sra2zxk4xp68-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391477machine # Could not acquire lock1478(finished: subtest: aborts on already locked lock file, in 0.05 seconds)1479subtest: fstab mounts1480machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&11481machine # [ 28.102413] nixos[2257]: switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1482machine # [ 28.104851] systemd[1]: Stopped target Local File Systems.1483machine # [ 28.106403] systemd[1]: Stopped target Remote File Systems.1484machine # [ 28.313036] systemd[1]: Reexecution requested from client PID 2257 ('.switch-to-conf') (unit backdoor.service)...1485machine # [ 28.317084] systemd[1]: Reexecuting.1486machine # [ 28.605963] systemd[1]: systemd 263-583679f 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)1487machine # [ 28.610954] systemd[1]: Detected virtualization kvm.1488machine # [ 28.612591] systemd[1]: Detected architecture x86-64.1489machine # [ 28.701391] systemd[1]: bpf-restrict-fs: LSM BPF program attached1490machine # [ 28.817512] systemd[1]: Reload requested from client PID 2257 ('.switch-to-conf') (unit backdoor.service)...1491machine # [ 28.819332] systemd[1]: Reloading...1492machine # [ 29.140888] systemd[1]: Reloading finished in 319 ms.1493machine # [ 29.204339] systemd[625]: Reexecution requested from client PID 2360 ('switch-to-confi')...1494machine # [ 29.206775] systemd[625]: Reexecuting.1495machine # [ 29.233334] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1496machine # [ 29.314236] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1497machine # [ 29.320818] systemd[625]: Reload requested from client PID 2360 ('switch-to-confi')...1498machine # [ 29.322445] systemd[625]: Reloading...1499machine # [ 29.404236] systemd[625]: Reloading finished in 80 ms.1500machine # [ 29.409951] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1501machine # [ 29.416796] systemd[625]: Stopped Run user-specific NixOS activation.1502machine # [ 29.417974] systemd[625]: Stopping Run user-specific NixOS activation...1503machine # [ 29.420975] systemd[625]: Starting Run user-specific NixOS activation...1504machine # [ 29.444670] systemd[625]: Finished Run user-specific NixOS activation.1505machine # [ 29.448607] systemd[1]: Stopped target Reactivate sysinit units.1506machine # [ 29.450237] systemd[1]: Stopping Reactivate sysinit units...1507machine # [ 29.451559] systemd[1]: Reached target Reactivate sysinit units.1508machine # [ 29.454305] systemd[1]: Reached target Local File Systems.1509machine # [ 29.456070] systemd[1]: Reached target Remote File Systems.1510machine # [ 29.459080] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1511machine # [ 29.461159] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1512machine # [ 29.463862] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1513machine # [ 29.468064] systemd[1]: Starting Create SUID/SGID Wrappers...1514machine # [ 29.470345] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1515machine # [ 29.471788] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671516machine # [ 29.473846] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1517machine # [ 29.475404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1518machine # [ 29.479150] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1519machine # [ 29.613415] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1520machine # [ 29.615094] systemd[1]: Finished Create SUID/SGID Wrappers.1521machine # [ 29.619630] systemd[1]: Starting linger-users.service...1522machine # [ 29.645206] systemd[1]: linger-users.service: Deactivated successfully.1523machine # [ 29.647270] systemd[1]: Finished linger-users.service.1524machine # [ 29.904095] nixos[2257]: finished switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1525machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1526machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11527machine # [ 30.117196] nixos[2431]: switching to system configuration /nix/store/af3grz83r4zq78sacgaqv7gi7083zbxz-nixos-system-machine-test1528machine # [ 30.118808] systemd[1]: Stopped target Local File Systems.1529machine # [ 30.120303] systemd[1]: Stopped target Remote File Systems.1530machine # [ 30.343825] systemd[1]: Reload requested from client PID 2431 ('.switch-to-conf') (unit backdoor.service)...1531machine # [ 30.345458] systemd[1]: Reloading...1532machine # [ 30.569286] systemd[1]: Reloading finished in 221 ms.1533machine # [ 30.631516] systemd[625]: Reexecution requested from client PID 2500 ('switch-to-confi')...1534machine # [ 30.632848] systemd[625]: Reexecuting.1535machine # [ 30.653069] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1536machine # [ 30.725919] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1537machine # [ 30.731794] systemd[625]: Reload requested from client PID 2500 ('switch-to-confi')...1538machine # [ 30.733430] systemd[625]: Reloading...1539machine # [ 30.809591] systemd[625]: Reloading finished in 75 ms.1540machine # [ 30.814857] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1541machine # [ 30.822074] systemd[625]: Stopped Run user-specific NixOS activation.1542machine # [ 30.823036] systemd[625]: Stopping Run user-specific NixOS activation...1543machine # [ 30.825183] systemd[625]: Starting Run user-specific NixOS activation...1544machine # [ 30.845415] systemd[625]: Finished Run user-specific NixOS activation.1545machine # [ 30.848421] systemd[1]: Stopped target Reactivate sysinit units.1546machine # [ 30.849789] systemd[1]: Stopping Reactivate sysinit units...1547machine # [ 30.850806] systemd[1]: Reached target Reactivate sysinit units.1548machine # [ 30.855685] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1549machine # [ 30.857596] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1550machine # [ 30.860248] systemd[1]: Reached target Remote File Systems.1551machine # [ 30.864767] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1552machine # [ 30.868306] systemd[1]: Starting Create SUID/SGID Wrappers...1553machine # [ 30.870126] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671554machine # [ 30.873206] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1555machine # [ 30.876060] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1556machine # [ 30.877908] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1557machine # [ 31.032750] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1558machine # [ 31.035259] systemd[1]: Finished Create SUID/SGID Wrappers.1559machine # [ 31.216893] systemd[1]: Mounting /test...1560machine # [ 31.235626] systemd[1]: Mounted /test.1561machine # [ 31.237177] systemd[1]: Reached target Local File Systems.1562machine # [ 31.239132] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1563machine # [ 31.241386] systemd[1]: Starting linger-users.service...1564machine # [ 31.267236] systemd[1]: linger-users.service: Deactivated successfully.1565machine # [ 31.268936] systemd[1]: Finished linger-users.service.1566machine # [ 31.524303] nixos[2431]: finished switching to system configuration /nix/store/af3grz83r4zq78sacgaqv7gi7083zbxz-nixos-system-machine-test1567machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 1.62 seconds)1568machine: must succeed: systemctl stop test.mount1569machine # [ 31.547799] systemd[1]: Stopped target Local File Systems.1570machine # [ 31.550928] systemd[1]: Unmounting /test...1571machine # [ 31.573241] systemd[1]: test.mount: Deactivated successfully.1572machine # [ 31.575167] systemd[1]: Unmounted /test.1573machine: (finished: must succeed: systemctl stop test.mount, in 0.05 seconds)1574machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11575machine # [ 31.762049] nixos[2580]: switching to system configuration /nix/store/af3grz83r4zq78sacgaqv7gi7083zbxz-nixos-system-machine-test1576machine # [ 31.764830] systemd[1]: Stopped target Remote File Systems.1577machine # [ 31.968211] systemd[1]: Reload requested from client PID 2580 ('.switch-to-conf') (unit backdoor.service)...1578machine # [ 31.969832] systemd[1]: Reloading...1579machine # [ 32.208823] systemd[1]: Reloading finished in 237 ms.1580machine # [ 32.268427] systemd[625]: Reexecution requested from client PID 2649 ('switch-to-confi')...1581machine # [ 32.270856] systemd[625]: Reexecuting.1582machine # [ 32.291302] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1583machine # [ 32.367285] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1584machine # [ 32.372304] systemd[625]: Reload requested from client PID 2649 ('switch-to-confi')...1585machine # [ 32.374591] systemd[625]: Reloading...1586machine # [ 32.444399] systemd[625]: Reloading finished in 70 ms.1587machine # [ 32.449861] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1588machine # [ 32.457072] systemd[625]: Stopped Run user-specific NixOS activation.1589machine # [ 32.457965] systemd[625]: Stopping Run user-specific NixOS activation...1590machine # [ 32.459984] systemd[625]: Starting Run user-specific NixOS activation...1591machine # [ 32.479511] systemd[625]: Finished Run user-specific NixOS activation.1592machine # [ 32.482543] systemd[1]: Stopped target Reactivate sysinit units.1593machine # [ 32.483742] systemd[1]: Stopping Reactivate sysinit units...1594machine # [ 32.484724] systemd[1]: Reached target Reactivate sysinit units.1595machine # [ 32.487585] systemd[1]: Reached target Remote File Systems.1596machine # [ 32.490566] systemd[1]: Starting linger-users.service...1597machine # [ 32.498421] systemd[1]: Mounting /test...1598machine # [ 32.499093] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1599machine # [ 32.502988] systemd[1]: Starting Create SUID/SGID Wrappers...1600machine # [ 32.504804] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671601machine # [ 32.507477] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1602machine # [ 32.510132] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1603machine # [ 32.511457] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1604machine # [ 32.519082] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1605machine # [ 32.520329] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1606machine # [ 32.556973] systemd[1]: Mounted /test.1607machine # [ 32.559357] systemd[1]: Reached target Local File Systems.1608machine # [ 32.560494] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1609machine # [ 32.577669] systemd[1]: linger-users.service: Deactivated successfully.1610machine # [ 32.579505] systemd[1]: Finished linger-users.service.1611machine # [ 32.685373] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1612machine # [ 32.687136] systemd[1]: Finished Create SUID/SGID Wrappers.1613machine # [ 32.942367] nixos[2580]: finished switching to system configuration /nix/store/af3grz83r4zq78sacgaqv7gi7083zbxz-nixos-system-machine-test1614machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 1.37 seconds)1615machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&11616machine # [ 33.127750] nixos[2722]: switching to system configuration /nix/store/7hc1prygsgwj81psdbkmhjb6gwvm8cpc-nixos-system-machine-test1617machine # [ 33.129780] systemd[1]: Stopped target Local File Systems.1618machine # [ 33.131528] systemd[1]: Stopped target Remote File Systems.1619machine # [ 33.354277] systemd[1]: Reload requested from client PID 2722 ('.switch-to-conf') (unit backdoor.service)...1620machine # [ 33.355919] systemd[1]: Reloading...1621machine # [ 33.574079] systemd[1]: Reloading finished in 216 ms.1622machine # [ 33.634954] systemd[625]: Reexecution requested from client PID 2791 ('switch-to-confi')...1623machine # [ 33.636921] systemd[625]: Reexecuting.1624machine # [ 33.659105] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1625machine # [ 33.728833] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1626machine # [ 33.734090] systemd[625]: Reload requested from client PID 2791 ('switch-to-confi')...1627machine # [ 33.735874] systemd[625]: Reloading...1628machine # [ 33.807292] systemd[625]: Reloading finished in 70 ms.1629machine # [ 33.812881] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1630machine # [ 33.820133] systemd[625]: Stopped Run user-specific NixOS activation.1631machine # [ 33.821058] systemd[625]: Stopping Run user-specific NixOS activation...1632machine # [ 33.823218] systemd[625]: Starting Run user-specific NixOS activation...1633machine # [ 33.842464] systemd[625]: Finished Run user-specific NixOS activation.1634machine # [ 33.845686] systemd[1]: Stopped target Reactivate sysinit units.1635machine # [ 33.847406] systemd[1]: Stopping Reactivate sysinit units...1636machine # [ 33.848869] systemd[1]: Reached target Reactivate sysinit units.1637machine # [ 33.850329] systemd[1]: Reloading /test...1638machine # [ 33.867322] systemd[1]: Reloaded /test.1639machine # [ 33.871995] systemd[1]: Reached target Local File Systems.1640machine # [ 33.873934] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1641machine # [ 33.877157] systemd[1]: Starting Create SUID/SGID Wrappers...1642machine # [ 33.877934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1643machine # [ 33.879142] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671644machine # [ 33.881122] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1645machine # [ 33.884363] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 33.888745] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1647machine # [ 33.889891] systemd[1]: Reached target Remote File Systems.1648machine # [ 33.897588] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1649machine # [ 33.899548] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1650machine # [ 34.019850] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1651machine # [ 34.021483] systemd[1]: Finished Create SUID/SGID Wrappers.1652machine # [ 34.025176] systemd[1]: Starting linger-users.service...1653machine # [ 34.053315] systemd[1]: linger-users.service: Deactivated successfully.1654machine # [ 34.054752] systemd[1]: Finished linger-users.service.1655machine # [ 34.309322] nixos[2722]: finished switching to system configuration /nix/store/7hc1prygsgwj81psdbkmhjb6gwvm8cpc-nixos-system-machine-test1656machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&1, in 1.37 seconds)1657machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&11658machine # [ 34.492354] nixos[2865]: switching to system configuration /nix/store/cbpybr15izd403kb8krqh81k19ixjd4i-nixos-system-machine-test1659machine # [ 34.494615] systemd[1]: Stopped target Local File Systems.1660machine # [ 34.495990] systemd[1]: Stopped target Remote File Systems.1661machine # [ 34.710433] systemd[1]: Reload requested from client PID 2865 ('.switch-to-conf') (unit backdoor.service)...1662machine # [ 34.712127] systemd[1]: Reloading...1663machine # [ 34.953144] systemd[1]: Reloading finished in 239 ms.1664machine # [ 35.016992] systemd[625]: Reexecution requested from client PID 2934 ('switch-to-confi')...1665machine # [ 35.019433] systemd[625]: Reexecuting.1666machine # [ 35.040101] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1667machine # [ 35.106566] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1668machine # [ 35.111721] systemd[625]: Reload requested from client PID 2934 ('switch-to-confi')...1669machine # [ 35.113112] systemd[625]: Reloading...1670machine # [ 35.181945] systemd[625]: Reloading finished in 67 ms.1671machine # [ 35.185824] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1672machine # [ 35.192045] systemd[625]: Stopped Run user-specific NixOS activation.1673machine # [ 35.193963] systemd[625]: Stopping Run user-specific NixOS activation...1674machine # [ 35.195464] systemd[625]: Starting Run user-specific NixOS activation...1675machine # [ 35.212910] systemd[625]: Finished Run user-specific NixOS activation.1676machine # [ 35.215875] systemd[1]: Stopped target Reactivate sysinit units.1677machine # [ 35.217170] systemd[1]: Stopping Reactivate sysinit units...1678machine # [ 35.217943] systemd[1]: Reached target Reactivate sysinit units.1679machine # [ 35.220210] systemd[1]: Unmounting /test...1680machine # [ 35.235698] systemd[1]: test.mount: Deactivated successfully.1681machine # [ 35.237057] systemd[1]: Unmounted /test.1682machine # [ 35.240369] systemd[1]: Mounting /test...1683machine # [ 35.255856] systemd[1]: Mounted /test.1684machine # [ 35.261283] systemd[1]: Reached target Local File Systems.1685machine # [ 35.263148] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1686machine # [ 35.265605] systemd[1]: Starting Create SUID/SGID Wrappers...1687machine # [ 35.267470] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1688machine # [ 35.269630] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671689machine # [ 35.273263] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1690machine # [ 35.274706] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1691machine # [ 35.276295] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1692machine # [ 35.277452] systemd[1]: Reached target Remote File Systems.1693machine # [ 35.282989] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1694machine # [ 35.284935] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1695machine # [ 35.409830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1696machine # [ 35.411472] systemd[1]: Finished Create SUID/SGID Wrappers.1697machine # [ 35.414994] systemd[1]: Starting linger-users.service...1698machine # [ 35.441533] systemd[1]: linger-users.service: Deactivated successfully.1699machine # [ 35.443865] systemd[1]: Finished linger-users.service.1700machine # [ 35.697554] nixos[2865]: finished switching to system configuration /nix/store/cbpybr15izd403kb8krqh81k19ixjd4i-nixos-system-machine-test1701machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&1, in 1.39 seconds)1702machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11703machine # [ 35.897279] nixos[3009]: switching to system configuration /nix/store/af3grz83r4zq78sacgaqv7gi7083zbxz-nixos-system-machine-test1704machine # [ 35.900159] systemd[1]: Stopped target Remote File Systems.1705machine # [ 35.901542] systemd[1]: Stopped target Local File Systems.1706machine # [ 36.112802] systemd[1]: Reload requested from client PID 3009 ('.switch-to-conf') (unit backdoor.service)...1707machine # [ 36.114491] systemd[1]: Reloading...1708machine # [ 36.362757] systemd[1]: Reloading finished in 246 ms.1709machine # [ 36.432799] systemd[625]: Reexecution requested from client PID 3078 ('switch-to-confi')...1710machine # [ 36.434853] systemd[625]: Reexecuting.1711machine # [ 36.456184] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1712machine # [ 36.531539] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1713machine # [ 36.536948] systemd[625]: Reload requested from client PID 3078 ('switch-to-confi')...1714machine # [ 36.538526] systemd[625]: Reloading...1715machine # [ 36.612039] systemd[625]: Reloading finished in 72 ms.1716machine # [ 36.617927] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1717machine # [ 36.624565] systemd[625]: Stopped Run user-specific NixOS activation.1718machine # [ 36.625564] systemd[625]: Stopping Run user-specific NixOS activation...1719machine # [ 36.628227] systemd[625]: Starting Run user-specific NixOS activation...1720machine # [ 36.649700] systemd[625]: Finished Run user-specific NixOS activation.1721machine # [ 36.653080] systemd[1]: Stopped target Reactivate sysinit units.1722machine # [ 36.654538] systemd[1]: Stopping Reactivate sysinit units...1723machine # [ 36.655471] systemd[1]: Reached target Reactivate sysinit units.1724machine # [ 36.657820] systemd[1]: Unmounting /test...1725machine # [ 36.675502] systemd[1]: test.mount: Deactivated successfully.1726machine # [ 36.676931] systemd[1]: Unmounted /test.1727machine # [ 36.680071] systemd[1]: Mounting /test...1728machine # [ 36.699734] systemd[1]: Mounted /test.1729machine # [ 36.704182] systemd[1]: Reached target Remote File Systems.1730machine # [ 36.705529] systemd[1]: Reached target Local File Systems.1731machine # [ 36.711069] systemd[1]: Starting linger-users.service...1732machine # [ 36.712906] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1733machine # [ 36.714925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1734machine # [ 36.721448] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1735machine # [ 36.726078] systemd[1]: Starting Create SUID/SGID Wrappers...1736machine # [ 36.726918] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1737machine # [ 36.728929] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671738machine # [ 36.731625] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1739machine # [ 36.733113] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1740machine # [ 36.734315] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1741machine # [ 36.775822] systemd[1]: linger-users.service: Deactivated successfully.1742machine # [ 36.777715] systemd[1]: Finished linger-users.service.1743machine # [ 36.893366] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1744machine # [ 36.896176] systemd[1]: Finished Create SUID/SGID Wrappers.1745machine # [ 37.153469] nixos[3009]: finished switching to system configuration /nix/store/af3grz83r4zq78sacgaqv7gi7083zbxz-nixos-system-machine-test1746machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 1.46 seconds)1747machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&11748machine # [ 37.410595] nixos[3153]: switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1749machine # [ 37.413335] systemd[1]: Stopped target Local File Systems.1750machine # [ 37.416125] systemd[1]: Unmounting /test...1751machine # [ 37.417633] systemd[1]: Stopped target Remote File Systems.1752machine # [ 37.437347] systemd[1]: test.mount: Deactivated successfully.1753machine # [ 37.439208] systemd[1]: Unmounted /test.1754machine # [ 37.652421] systemd[1]: Reload requested from client PID 3153 ('.switch-to-conf') (unit backdoor.service)...1755machine # [ 37.654417] systemd[1]: Reloading...1756machine # [ 37.957109] systemd[1]: Reloading finished in 300 ms.1757machine # [ 38.021339] systemd[625]: Reexecution requested from client PID 3225 ('switch-to-confi')...1758machine # [ 38.023857] systemd[625]: Reexecuting.1759machine # [ 38.048329] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1760machine # [ 38.126114] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1761machine # [ 38.131754] systemd[625]: Reload requested from client PID 3225 ('switch-to-confi')...1762machine # [ 38.133120] systemd[625]: Reloading...1763machine # [ 38.207075] systemd[625]: Reloading finished in 72 ms.1764machine # [ 38.212927] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1765machine # [ 38.219201] systemd[625]: Stopped Run user-specific NixOS activation.1766machine # [ 38.221134] systemd[625]: Stopping Run user-specific NixOS activation...1767machine # [ 38.222888] systemd[625]: Starting Run user-specific NixOS activation...1768machine # [ 38.245147] systemd[625]: Finished Run user-specific NixOS activation.1769machine # [ 38.248445] systemd[1]: Stopped target Reactivate sysinit units.1770machine # [ 38.250197] systemd[1]: Stopping Reactivate sysinit units...1771machine # [ 38.251574] systemd[1]: Reached target Reactivate sysinit units.1772machine # [ 38.254772] systemd[1]: Reached target Remote File Systems.1773machine # [ 38.257784] systemd[1]: Starting linger-users.service...1774machine # [ 38.260056] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1775machine # [ 38.261787] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1776machine # [ 38.269715] systemd[1]: Reached target Local File Systems.1777machine # [ 38.273864] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1778machine # [ 38.279155] systemd[1]: Starting Create SUID/SGID Wrappers...1779machine # [ 38.280844] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1780machine # [ 38.282906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671781machine # [ 38.286100] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1782machine # [ 38.287793] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1783machine # [ 38.289468] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1784machine # [ 38.327092] systemd[1]: linger-users.service: Deactivated successfully.1785machine # [ 38.329497] systemd[1]: Finished linger-users.service.1786machine # [ 38.442580] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1787machine # [ 38.444427] systemd[1]: Finished Create SUID/SGID Wrappers.1788machine # [ 38.699543] nixos[3153]: finished switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1789machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.54 seconds)1790machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&11791machine # [ 38.896198] nixos[3296]: switching to system configuration /nix/store/inkl7p8j5gb75jxmhr4816lbkv6f5ymn-nixos-system-machine-test1792machine # [ 38.899714] systemd[1]: Stopped target Local File Systems.1793machine # [ 38.900863] systemd[1]: Stopped target Remote File Systems.1794machine # [ 39.147861] systemd[1]: Reload requested from client PID 3296 ('.switch-to-conf') (unit backdoor.service)...1795machine # [ 39.149694] systemd[1]: Reloading...1796machine # [ 39.395975] systemd[1]: Reloading finished in 245 ms.1797machine # [ 39.461715] systemd[625]: Reexecution requested from client PID 3365 ('switch-to-confi')...1798machine # [ 39.464192] systemd[625]: Reexecuting.1799machine # [ 39.486267] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 39.561905] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1801machine # [ 39.567352] systemd[625]: Reload requested from client PID 3365 ('switch-to-confi')...1802machine # [ 39.568545] systemd[625]: Reloading...1803machine # [ 39.642844] systemd[625]: Reloading finished in 72 ms.1804machine # [ 39.647875] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1805machine # [ 39.655074] systemd[625]: Stopped Run user-specific NixOS activation.1806machine # [ 39.655988] systemd[625]: Stopping Run user-specific NixOS activation...1807machine # [ 39.658111] systemd[625]: Starting Run user-specific NixOS activation...1808machine # [ 39.679449] systemd[625]: Finished Run user-specific NixOS activation.1809machine # [ 39.682968] systemd[1]: Stopped target Reactivate sysinit units.1810machine # [ 39.684698] systemd[1]: Stopping Reactivate sysinit units...1811machine # [ 39.686161] systemd[1]: Reached target Reactivate sysinit units.1812machine # [ 39.686980] systemd[1]: Reached target Remote File Systems.1813machine # [ 39.690734] systemd[1]: Reached target Local File Systems.1814machine # [ 39.693115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1815machine # [ 39.695238] systemd[1]: Starting Create SUID/SGID Wrappers...1816machine # [ 39.697160] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1817machine # [ 39.698783] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671818machine # [ 39.700723] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1819machine # [ 39.704049] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1820machine # [ 39.707174] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1821machine # [ 39.713728] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1822machine # [ 39.715484] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1823machine # [ 39.842220] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1824machine # [ 39.843841] systemd[1]: Finished Create SUID/SGID Wrappers.1825machine # [ 39.848182] systemd[1]: Starting linger-users.service...1826machine # [ 39.877453] systemd[1]: linger-users.service: Deactivated successfully.1827machine # [ 39.878913] systemd[1]: Finished linger-users.service.1828machine # [ 40.133727] nixos[3296]: finished switching to system configuration /nix/store/inkl7p8j5gb75jxmhr4816lbkv6f5ymn-nixos-system-machine-test1829machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&1, in 1.43 seconds)1830machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&11831machine # [ 40.317963] nixos[3436]: switching to system configuration /nix/store/nq9vg85dg5l0rs07gbw3zzpyflzj50b3-nixos-system-machine-test1832machine # [ 40.321173] systemd[1]: Stopped target Remote File Systems.1833machine # [ 40.321967] systemd[1]: Stopped target Local File Systems.1834machine # [ 40.624966] systemd[1]: Reload requested from client PID 3436 ('.switch-to-conf') (unit backdoor.service)...1835machine # [ 40.626704] systemd[1]: Reloading...1836machine # [ 40.862369] systemd[1]: Reloading finished in 233 ms.1837machine # [ 40.924467] systemd[625]: Reexecution requested from client PID 3506 ('switch-to-confi')...1838machine # [ 40.925860] systemd[625]: Reexecuting.1839machine # [ 40.946114] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1840machine # [ 41.018577] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1841machine # [ 41.024092] systemd[625]: Reload requested from client PID 3506 ('switch-to-confi')...1842machine # [ 41.025448] systemd[625]: Reloading...1843machine # [ 41.098146] systemd[625]: Reloading finished in 71 ms.1844machine # [ 41.103849] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1845machine # [ 41.111081] systemd[625]: Stopped Run user-specific NixOS activation.1846machine # [ 41.111977] systemd[625]: Stopping Run user-specific NixOS activation...1847machine # [ 41.113871] systemd[625]: Starting Run user-specific NixOS activation...1848machine # [ 41.133391] systemd[625]: Finished Run user-specific NixOS activation.1849machine # [ 41.136419] systemd[1]: Stopped target Reactivate sysinit units.1850machine # [ 41.137805] systemd[1]: Stopping Reactivate sysinit units...1851machine # [ 41.138869] systemd[1]: Reached target Reactivate sysinit units.1852machine # [ 41.140895] systemd[1]: Reached target Remote File Systems.1853machine # [ 41.146424] systemd[1]: Starting linger-users.service...1854machine # [ 41.151498] systemd[1]: Set up automount testauto.automount.1855machine # [ 41.152339] systemd[1]: Reached target Local File Systems.1856machine # [ 41.153110] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1857machine # [ 41.156534] systemd[1]: Starting Create SUID/SGID Wrappers...1858machine # [ 41.158618] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1859machine # [ 41.159796] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671860machine # [ 41.164058] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1861machine # [ 41.165587] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1862machine # [ 41.166767] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1863machine # [ 41.173571] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1864machine # [ 41.174826] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1865machine # [ 41.215837] systemd[1]: linger-users.service: Deactivated successfully.1866machine # [ 41.217597] systemd[1]: Finished linger-users.service.1867machine # [ 41.317072] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1868machine # [ 41.319574] systemd[1]: Finished Create SUID/SGID Wrappers.1869machine # [ 41.576729] nixos[3436]: finished switching to system configuration /nix/store/nq9vg85dg5l0rs07gbw3zzpyflzj50b3-nixos-system-machine-test1870machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&1, in 1.44 seconds)1871machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&11872machine # [ 41.738285] nixos[3577]: switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1873machine # [ 41.740819] systemd[1]: Stopped target Remote File Systems.1874machine # [ 41.742294] systemd[1]: Stopped target Local File Systems.1875machine # [ 41.743755] systemd[1]: testauto.automount: Deactivated successfully.1876machine # [ 41.746103] systemd[1]: Unset automount testauto.automount.1877machine # [ 41.948993] systemd[1]: Reload requested from client PID 3577 ('.switch-to-conf') (unit backdoor.service)...1878machine # [ 41.950812] systemd[1]: Reloading...1879machine # [ 42.181974] systemd[1]: Reloading finished in 229 ms.1880machine # [ 42.242547] systemd[625]: Reexecution requested from client PID 3646 ('switch-to-confi')...1881machine # [ 42.244185] systemd[625]: Reexecuting.1882machine # [ 42.265112] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1883machine # [ 42.335737] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1884machine # [ 42.340774] systemd[625]: Reload requested from client PID 3646 ('switch-to-confi')...1885machine # [ 42.341965] systemd[625]: Reloading...1886machine # [ 42.413666] systemd[625]: Reloading finished in 70 ms.1887machine # [ 42.418817] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1888machine # [ 42.424972] systemd[625]: Stopped Run user-specific NixOS activation.1889machine # [ 42.425967] systemd[625]: Stopping Run user-specific NixOS activation...1890machine # [ 42.428564] systemd[625]: Starting Run user-specific NixOS activation...1891machine # [ 42.448735] systemd[625]: Finished Run user-specific NixOS activation.1892machine # [ 42.451846] systemd[1]: Stopped target Reactivate sysinit units.1893machine # [ 42.452894] systemd[1]: Stopping Reactivate sysinit units...1894machine # [ 42.454125] systemd[1]: Reached target Reactivate sysinit units.1895machine # [ 42.455556] systemd[1]: Reached target Local File Systems.1896machine # [ 42.458260] systemd[1]: Reached target Remote File Systems.1897machine # [ 42.459746] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1898machine # [ 42.461255] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1899machine # [ 42.466937] systemd[1]: Starting linger-users.service...1900machine # [ 42.475116] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1901machine # [ 42.480040] systemd[1]: Starting Create SUID/SGID Wrappers...1902machine # [ 42.480910] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1903machine # [ 42.482073] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671904machine # [ 42.486437] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1905machine # [ 42.489118] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1906machine # [ 42.490601] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1907machine # [ 42.523509] systemd[1]: linger-users.service: Deactivated successfully.1908machine # [ 42.525794] systemd[1]: Finished linger-users.service.1909machine # [ 42.634512] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1910machine # [ 42.636318] systemd[1]: Finished Create SUID/SGID Wrappers.1911machine # [ 42.893944] nixos[3577]: finished switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1912machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.32 seconds)1913(finished: subtest: fstab mounts, in 14.99 seconds)1914subtest: swaps1915machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&11916machine # [ 43.117439] nixos[3717]: switching to system configuration /nix/store/mkjhd6ay4z1xwpd6imcnqjhk8ibm6g5n-nixos-system-machine-test1917machine # [ 43.120792] systemd[1]: Stopped target Remote File Systems.1918machine # [ 43.121823] systemd[1]: Stopped target Local File Systems.1919machine # [ 43.343319] systemd[1]: Reload requested from client PID 3717 ('.switch-to-conf') (unit backdoor.service)...1920machine # [ 43.344803] systemd[1]: Reloading...1921machine # [ 43.607422] systemd[1]: Reloading finished in 261 ms.1922machine # [ 43.669353] systemd[625]: Reexecution requested from client PID 3786 ('switch-to-confi')...1923machine # [ 43.670972] systemd[625]: Reexecuting.1924machine # [ 43.691052] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1925machine # [ 43.762621] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1926machine # [ 43.767789] systemd[625]: Reload requested from client PID 3786 ('switch-to-confi')...1927machine # [ 43.769307] systemd[625]: Reloading...1928machine # [ 43.840557] systemd[625]: Reloading finished in 69 ms.1929machine # [ 43.844828] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1930machine # [ 43.850711] systemd[625]: Stopped Run user-specific NixOS activation.1931machine # [ 43.852228] systemd[625]: Stopping Run user-specific NixOS activation...1932machine # [ 43.854186] systemd[625]: Starting Run user-specific NixOS activation...1933machine # [ 43.872966] systemd[625]: Finished Run user-specific NixOS activation.1934machine # [ 43.875848] systemd[1]: Stopped target Reactivate sysinit units.1935machine # [ 43.877202] systemd[1]: Stopping Reactivate sysinit units...1936machine # [ 43.877971] systemd[1]: Reached target Reactivate sysinit units.1937machine # [ 43.881491] systemd[1]: Starting Initialisation of swap device /swapfile...1938machine # [ 43.883930] systemd[1]: Reached target Remote File Systems.1939machine # [ 43.888486] systemd[1]: Starting linger-users.service...1940machine # [ 43.889246] systemd[1]: Reached target Local File Systems.1941machine # [ 43.895268] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1942machine # [ 43.896524] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1943machine # [ 43.902473] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1944machine # [ 43.906166] systemd[1]: Starting Create SUID/SGID Wrappers...1945machine # [ 43.906987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1946machine # [ 43.910639] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671947machine # [ 43.913744] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1948machine # [ 43.917110] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1949machine # [ 43.918365] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1950machine # [ 43.967185] systemd[1]: linger-users.service: Deactivated successfully.1951machine # [ 43.970515] systemd[1]: Finished linger-users.service.1952machine # [ 43.978514] mkswap-swapfile-start[3798]: Creating swap file using dd and mkswap.1953machine # [ 43.995416] mkswap-swapfile-start[3820]: 1+0 records in1954machine # [ 43.996801] mkswap-swapfile-start[3820]: 1+0 records out1955machine # [ 43.997845] mkswap-swapfile-start[3820]: 1048576 bytes (1.0 MB, 1.0 MiB) copied, 0.00239164 s, 438 MB/s1956machine # [ 44.008824] mkswap-swapfile-start[3823]: Setting up swapspace version 1, size = 1020 KiB (1044480 bytes)1957machine # [ 44.010570] mkswap-swapfile-start[3823]: no label, UUID=38b09c55-3ba3-40a7-a251-1ed2ea7f5cf21958machine # [ 44.013678] systemd[1]: mkswap-swapfile.service: Deactivated successfully.1959machine # [ 44.015388] systemd[1]: Finished Initialisation of swap device /swapfile.1960machine # [ 44.017621] systemd[1]: mkswap-swapfile.service: Consumed 28ms CPU time over 133ms wall clock time, 3.1M memory peak, 1M written to disk.1961machine # [ 44.021908] systemd[1]: Activating swap /swapfile...1962machine # [ 44.188421] Adding 1020k swap on /swapfile. Priority:-2 extents:1 across:1020k1963machine # [ 44.048166] systemd[1]: Activated swap /swapfile.1964machine # [ 44.118141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1965machine # [ 44.119908] systemd[1]: Finished Create SUID/SGID Wrappers.1966machine # [ 44.377810] nixos[3717]: finished switching to system configuration /nix/store/mkjhd6ay4z1xwpd6imcnqjhk8ibm6g5n-nixos-system-machine-test1967machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&1, in 1.48 seconds)1968machine: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&11969machine # [ 44.592545] systemd[1]: swapfile.swap: Deactivated successfully.1970machine # [ 44.594831] nixos[3871]: switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test1971machine # [ 44.596585] systemd[1]: Stopped target Local File Systems.1972machine # [ 44.597964] systemd[1]: Stopped target Remote File Systems.1973machine # [ 44.802883] systemd[1]: Reload requested from client PID 3871 ('.switch-to-conf') (unit backdoor.service)...1974machine # [ 44.804485] systemd[1]: Reloading...1975machine # [ 45.036504] systemd[1]: Reloading finished in 230 ms.1976machine # [ 45.098390] systemd[625]: Reexecution requested from client PID 3940 ('switch-to-confi')...1977machine # [ 45.100108] systemd[625]: Reexecuting.1978machine # [ 45.119976] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1979machine # [ 45.192449] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1980machine # [ 45.197738] systemd[625]: Reload requested from client PID 3940 ('switch-to-confi')...1981machine # [ 45.199410] systemd[625]: Reloading...1982machine # [ 45.270930] systemd[625]: Reloading finished in 70 ms.1983machine # [ 45.276814] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1984machine # [ 45.283144] systemd[625]: Stopped Run user-specific NixOS activation.1985machine # [ 45.284049] systemd[625]: Stopping Run user-specific NixOS activation...1986machine # [ 45.286176] systemd[625]: Starting Run user-specific NixOS activation...1987machine # [ 45.305293] systemd[625]: Finished Run user-specific NixOS activation.1988machine # [ 45.308294] systemd[1]: Stopped target Reactivate sysinit units.1989machine # [ 45.309483] systemd[1]: Stopping Reactivate sysinit units...1990machine # [ 45.310644] systemd[1]: Reached target Reactivate sysinit units.1991machine # [ 45.312783] systemd[1]: Reached target Remote File Systems.1992machine # [ 45.315644] systemd[1]: Starting linger-users.service...1993machine # [ 45.321347] systemd[1]: Reached target Local File Systems.1994machine # [ 45.322175] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1995machine # [ 45.325149] systemd[1]: Starting Create SUID/SGID Wrappers...1996machine # [ 45.325964] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1997machine # [ 45.329136] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671998machine # [ 45.331170] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1999machine # [ 45.334434] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2000machine # [ 45.337299] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2001machine # [ 45.340660] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2002machine # [ 45.341898] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2003machine # [ 45.379618] systemd[1]: linger-users.service: Deactivated successfully.2004machine # [ 45.381443] systemd[1]: Finished linger-users.service.2005machine # [ 45.489107] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2006machine # [ 45.491819] systemd[1]: Finished Create SUID/SGID Wrappers.2007machine # [ 45.748904] nixos[3871]: finished switching to system configuration /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test2008machine: (finished: must succeed: /nix/store/v0r2l2qzv6mbr5k9ki2jli205vdg0p6g-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.37 seconds)2009(finished: subtest: swaps, in 2.85 seconds)2010(finished: run the VM test script, in 46.69 seconds)2011test script finished in 47.20s2012cleanup2013kill QemuMachine (pid 45)2014machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)2015machine # [2026-09-29T03:56:15Z INFO virtiofsd] Client disconnected, shutting down2016machine # [2026-09-29T03:56:15Z INFO virtiofsd] Client disconnected, shutting down2017machine # [2026-09-29T03:56:15Z INFO virtiofsd] Client disconnected, shutting down2018(finished: cleanup, in 0.17 seconds)2019additionally exposed symbols:2020 machine, other,2021 vlan1,2022 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