tribuchet: building on jamie [0.00s] Machine state will be reset. To keep it, pass --keep-machine-state [0.00s] start all VLans [0.00s] (finished: start all VLans, in 0.00 seconds) [0.00s] Test will time out and terminate in 3600.0 seconds [0.01s] run the VM test script [0.01s] server: waiting for unit niks3.service [0.01s] server: waiting for the VM to finish booting [0.01s] server: starting vm server # Disk image does not exist, creating the virtualisation disk image... [0.20s] server: QEMU running (pid 45) server # Formatting '/build/vm-state-server/tmp.yK8y4IJwSp', fmt=raw size=1073741824 server # mke2fs 1.47.4 (6-Mar-2025) server # Discarding device blocks: 0/262144 done server # Creating filesystem with 262144 4k blocks and 65536 inodes server # Filesystem UUID: eaac7a8b-9b03-4e1e-966d-a7c1f48c7cff server # Superblock backups stored on blocks: server # 32768, 98304, 163840, 229376 server # server # Allocating group tables: 0/8 done server # Writing inode tables: 0/8 done server # Creating journal (8192 blocks): done server # Writing superblocks and filesystem accounting information: 0/8 done server # server # Virtualisation disk image created. server # Starting virtiofs daemons... server # [2026-11-12T07:15:14Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) server # [2026-11-12T07:15:14Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether server # [2026-11-12T07:15:14Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) server # [2026-11-12T07:15:14Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether server # [2026-11-12T07:15:14Z INFO virtiofsd] Waiting for vhost-user socket connection... server # [2026-11-12T07:15:14Z INFO virtiofsd] Waiting for vhost-user socket connection... server # [2026-11-12T07:15:14Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) server # [2026-11-12T07:15:14Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether server # [2026-11-12T07:15:14Z INFO virtiofsd] Waiting for vhost-user socket connection... server # [2026-11-12T07:15:14Z INFO virtiofsd] Client connected, servicing requests server # [2026-11-12T07:15:14Z INFO virtiofsd] Client connected, servicing requests server # [2026-11-12T07:15:14Z INFO virtiofsd] Client connected, servicing requests server # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) server # server # server # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 server # Press Ctrl-B to configure iPXE (PCI 00:02.0)... server # server # server # server # server # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 server # Press Ctrl-B to configure iPXE (PCI 00:05.0)... server # server # server # Booting from ROM... server # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.60 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1793362001 server # [ 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/9ij3wqhfccmkcrsrfk94hqyq0rkfgyis-nixos-system-server-test/init regInfo=/nix/.ro-store/6nzy14ryr9dg9im0pj5x56jzrigj4314-closure-info/registration console=ttyS0,115200n8 console=tty0 server # [ 0.000000] BIOS-provided physical RAM map: server # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable server # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable server # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved server # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved server # [ 0.000000] NX (Execute Disable) protection: active server # [ 0.000000] APIC: Static calls initialized server # [ 0.000000] SMBIOS 2.8 present. server # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 server # [ 0.000000] DMI: Memory slots populated: 1/1 server # [ 0.000000] Hypervisor detected: KVM server # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 server # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 server # [ 0.000000] kvm-clock: using sched offset of 492246928 cycles server # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns server # [ 0.000005] tsc: Detected 2400.012 MHz processor server # [ 0.000764] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 server # [ 0.000790] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs server # [ 0.000793] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT server # [ 0.002681] found SMP MP-table at [mem 0x000f5450-0x000f545f] server # [ 0.002692] Using GB pages for direct mapping server # [ 0.002777] RAMDISK: [mem 0x3e436000-0x3ffcffff] server # [ 0.002785] ACPI: Early table checksum verification disabled server # [ 0.002788] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) server # [ 0.002792] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002796] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002804] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002806] ACPI: FACS 0x000000003FFE0000 000040 server # [ 0.002808] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002809] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002811] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002812] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) server # [ 0.002814] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] server # [ 0.002815] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] server # [ 0.002815] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] server # [ 0.002816] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] server # [ 0.002816] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] server # [ 0.002817] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] server # [ 0.002817] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] server # [ 0.003044] No NUMA configuration found server # [ 0.003045] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] server # [ 0.003047] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] server # [ 0.005214] Zone ranges: server # [ 0.005215] DMA [mem 0x0000000000001000-0x0000000000ffffff] server # [ 0.005216] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] server # [ 0.005218] Normal empty server # [ 0.005218] Device empty server # [ 0.005219] Movable zone start for each node server # [ 0.005220] Early memory node ranges server # [ 0.005220] node 0: [mem 0x0000000000001000-0x000000000009efff] server # [ 0.005221] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] server # [ 0.005222] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] server # [ 0.005241] On node 0, zone DMA: 1 pages in unavailable ranges server # [ 0.005498] On node 0, zone DMA: 97 pages in unavailable ranges server # [ 0.022289] On node 0, zone DMA32: 40 pages in unavailable ranges server # [ 0.022741] ACPI: PM-Timer IO Port: 0x608 server # [ 0.022752] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) server # [ 0.022779] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 server # [ 0.022782] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) server # [ 0.022783] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) server # [ 0.022784] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) server # [ 0.022785] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) server # [ 0.022786] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) server # [ 0.022788] ACPI: Using ACPI (MADT) for SMP configuration information server # [ 0.022789] ACPI: HPET id: 0x8086a201 base: 0xfed00000 server # [ 0.022792] TSC deadline timer available server # [ 0.022796] CPU topo: Max. logical packages: 1 server # [ 0.022797] CPU topo: Max. logical dies: 1 server # [ 0.022798] CPU topo: Max. dies per package: 1 server # [ 0.022801] CPU topo: Max. threads per core: 1 server # [ 0.022801] CPU topo: Num. cores per package: 1 server # [ 0.022802] CPU topo: Num. threads per package: 1 server # [ 0.022802] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs server # [ 0.022819] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() server # [ 0.022847] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] server # [ 0.022848] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] server # [ 0.022850] [mem 0x40000000-0xafffffff] available for PCI devices server # [ 0.022851] Booting paravirtualized kernel on KVM server # [ 0.022853] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns server # [ 0.027508] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 server # [ 0.029598] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 server # [ 0.029643] kvm-guest: PV spinlocks disabled, single CPU server # [ 0.029644] 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/9ij3wqhfccmkcrsrfk94hqyq0rkfgyis-nixos-system-server-test/init regInfo=/nix/.ro-store/6nzy14ryr9dg9im0pj5x56jzrigj4314-closure-info/registration console=ttyS0,115200n8 console=tty0 server # [ 0.029734] Unknown kernel command line parameters "regInfo=/nix/.ro-store/6nzy14ryr9dg9im0pj5x56jzrigj4314-closure-info/registration", will be passed to user space. server # [ 0.029747] random: crng init done server # [ 0.029747] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes server # [ 0.029768] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) server # [ 0.029780] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) server # [ 0.029810] Fallback order for Node 0: 0 server # [ 0.029813] Built 1 zonelists, mobility grouping on. Total pages: 262006 server # [ 0.029814] Policy zone: DMA32 server # [ 0.032324] mem auto-init: stack:all(zero), heap alloc:on, heap free:off server # [ 0.034663] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 server # [ 0.036803] allocated 2097152 bytes of page_ext server # [ 0.046424] ftrace: allocating 49004 entries in 192 pages server # [ 0.046433] ftrace: allocated 192 pages with 2 groups server # [ 0.047230] Dynamic Preempt: lazy server # [ 0.047353] rcu: Preemptible hierarchical RCU implementation. server # [ 0.047354] rcu: RCU event tracing is enabled. server # [ 0.047354] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. server # [ 0.047356] Trampoline variant of Tasks RCU enabled. server # [ 0.047356] Rude variant of Tasks RCU enabled. server # [ 0.047356] Tracing variant of Tasks RCU enabled. server # [ 0.047357] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. server # [ 0.047358] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 server # [ 0.047367] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. server # [ 0.047369] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. server # [ 0.047370] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. server # [ 0.051605] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 server # [ 0.051911] rcu: srcu_init: Setting srcu_struct sizes based on contention. server # [ 0.051918] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns server # [ 0.052016] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) server # [ 0.055538] Console: colour VGA+ 80x25 server # [ 0.055541] printk: legacy console [tty0] enabled server # [ 0.084985] printk: legacy console [ttyS0] enabled server # [ 0.188617] ACPI: Core revision 20250807 server # [ 0.189489] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns server # [ 0.191089] APIC: Switch to symmetric I/O mode setup server # [ 0.192133] x2apic enabled server # [ 0.192883] APIC: Switched APIC routing to: physical x2apic server # [ 0.194792] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 server # [ 0.195829] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns server # [ 0.197559] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) server # [ 0.198644] x86/cpu: User Mode Instruction Prevention (UMIP) activated server # [ 0.200692] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 server # [ 0.201557] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 server # [ 0.202560] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto server # [ 0.203556] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl server # [ 0.204556] Transient Scheduler Attacks: Vulnerable: No microcode server # [ 0.205556] Spectre V2 : Mitigation: Enhanced / Automatic IBRS server # [ 0.206556] Speculative Return Stack Overflow: Mitigation: Safe RET server # [ 0.207556] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization server # [ 0.209564] Spectre V2 : Enabling IBPB for BPF server # [ 0.210557] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier server # [ 0.211557] active return thunk: srso_alias_return_thunk server # [ 0.213252] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' server # [ 0.214556] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' server # [ 0.215556] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' server # [ 0.216556] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' server # [ 0.217556] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' server # [ 0.218556] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' server # [ 0.219556] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' server # [ 0.220557] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 server # [ 0.221556] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 server # [ 0.222556] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 server # [ 0.224341] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 server # [ 0.225322] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 server # [ 0.226334] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. server # [ 0.259748] Freeing SMP alternatives memory: 48K server # [ 0.260559] pid_max: default: 32768 minimum: 301 server # [ 0.261430] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima server # [ 0.262657] landlock: Up and running. server # [ 0.263307] Yama: becoming mindful. server # [ 0.264215] LSM support for eBPF active server # [ 0.264647] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) server # [ 0.265578] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) server # [ 0.268743] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) server # [ 0.270108] Performance Events: Fam17h+ core perfctr, AMD PMU driver. server # [ 0.270565] ... version: 2 server # [ 0.271311] ... bit width: 48 server # [ 0.271559] ... generic counters: 6 server # [ 0.272290] ... generic bitmap: 000000000000003f server # [ 0.272559] ... fixed-purpose counters: 0 server # [ 0.273306] ... fixed-purpose bitmap: 0000000000000000 server # [ 0.273558] ... value mask: 0000ffffffffffff server # [ 0.274501] ... max period: 00007fffffffffff server # [ 0.275293] ... global_ctrl mask: 000000000000003f server # [ 0.275669] signal: max sigframe size: 3376 server # [ 0.276521] rcu: Hierarchical SRCU implementation. server # [ 0.277172] rcu: Max phase no-delay instances is 400. server # [ 0.282335] smp: Bringing up secondary CPUs ... server # [ 0.282573] smp: Brought up 1 node, 1 CPU server # [ 0.283290] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) server # [ 0.283779] Memory: 935716K/1048024K available (18198K kernel code, 5432K rwdata, 13720K rodata, 6720K init, 3992K bss, 104928K reserved, 0K cma-reserved) server # [ 0.284770] devtmpfs: initialized server # [ 0.285553] x86/mm: Memory block size: 128MB server # [ 0.287076] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) server # [ 0.287582] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). server # [ 0.288648] pinctrl core: initialized pinctrl subsystem server # [ 0.289800] PM: RTC time: 07:15:14, date: 2026-11-12 server # [ 0.293375] NET: Registered PF_NETLINK/PF_ROUTE protocol family server # [ 0.294701] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations server # [ 0.295574] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations server # [ 0.296700] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations server # [ 0.297568] audit: initializing netlink subsys (disabled) server # [ 0.298709] thermal_sys: Registered thermal governor 'fair_share' server # [ 0.298711] thermal_sys: Registered thermal governor 'bang_bang' server # [ 0.299560] thermal_sys: Registered thermal governor 'step_wise' server # [ 0.300550] thermal_sys: Registered thermal governor 'user_space' server # [ 0.301347] audit: type=2000 audit(1794467715.469:1): state=initialized audit_enabled=0 res=1 server # [ 0.303563] thermal_sys: Registered thermal governor 'power_allocator' server # [ 0.303587] cpuidle: using governor menu server # [ 0.305831] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 server # [ 0.306789] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] server # [ 0.307562] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry server # [ 0.308572] PCI: Using configuration type 1 for base access server # [ 0.309707] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. server # [ 0.314794] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages server # [ 0.315560] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page server # [ 0.320560] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages server # [ 0.321559] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page server # [ 0.331952] ACPI: Added _OSI(Module Device) server # [ 0.332561] ACPI: Added _OSI(Processor Device) server # [ 0.333308] ACPI: Added _OSI(Processor Aggregator Device) server # [ 0.342123] ACPI: 1 ACPI AML tables successfully acquired and loaded server # [ 0.345825] ACPI: Interpreter enabled server # [ 0.346510] ACPI: PM: (supports S0 S3 S4 S5) server # [ 0.347084] ACPI: Using IOAPIC for interrupt routing server # [ 0.347595] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug server # [ 0.348559] PCI: Using E820 reservations for host bridge windows server # [ 0.351701] ACPI: Enabled 2 GPEs in block 00 to 3F server # [ 0.359468] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) server # [ 0.360398] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] server # [ 0.361635] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] server # [ 0.362691] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] server # [ 0.363920] PCI host bridge to bus 0000:00 server # [ 0.364563] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] server # [ 0.365559] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] server # [ 0.366559] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] server # [ 0.367559] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] server # [ 0.368559] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] server # [ 0.369559] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] server # [ 0.370559] pci_bus 0000:00: root bus resource [bus 00-ff] server # [ 0.371560] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint server # [ 0.373056] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint server # [ 0.375644] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] server # [ 0.376637] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] server # [ 0.377623] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] server # [ 0.378916] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] server # [ 0.381267] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint server # [ 0.384599] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] server # [ 0.385493] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] server # [ 0.386369] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] server # [ 0.387460] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] server # [ 0.389530] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint server # [ 0.392438] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] server # [ 0.393273] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] server # [ 0.393581] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] server # [ 0.395147] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint server # [ 0.398532] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] server # [ 0.399255] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] server # [ 0.399581] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] server # [ 0.401101] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint server # [ 0.403501] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] server # [ 0.404273] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] server # [ 0.404611] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] server # [ 0.406468] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] server # [ 0.407948] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint server # [ 0.409572] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] server # [ 0.410580] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] server # [ 0.412125] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint server # [ 0.414560] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] server # [ 0.415582] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] server # [ 0.417170] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint server # [ 0.418604] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] server # [ 0.419581] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] server # [ 0.421090] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint server # [ 0.422606] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] server # [ 0.423581] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] server # [ 0.425101] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint server # [ 0.427417] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] server # [ 0.428260] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] server # [ 0.428581] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] server # [ 0.430102] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint server # [ 0.432343] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] server # [ 0.433228] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] server # [ 0.433580] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] server # [ 0.435119] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint server # [ 0.436242] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] server # [ 0.436758] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint server # [ 0.438376] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] server # [ 0.439608] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint server # [ 0.441292] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] server # [ 0.441771] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint server # [ 0.444566] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] server # [ 0.445801] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint server # [ 0.446858] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO server # [ 0.447835] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint server # [ 0.449587] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] server # [ 0.450486] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] server # [ 0.451679] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint server # [ 0.453356] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] server # [ 0.456626] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 server # [ 0.457667] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 server # [ 0.458660] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 server # [ 0.459654] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 server # [ 0.460662] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 server # [ 0.461657] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 server # [ 0.462661] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 server # [ 0.463658] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 server # [ 0.464593] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 server # [ 0.465575] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 server # [ 0.466573] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 server # [ 0.467571] ACPI: PCI: Interrupt link GSID configured for IRQ 19 server # [ 0.468561] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 server # [ 0.469546] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 server # [ 0.470491] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 server # [ 0.471322] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 server # [ 0.472629] iommu: Default domain type: Translated server # [ 0.473452] iommu: DMA domain TLB invalidation policy: lazy mode server # [ 0.474575] ACPI: bus type USB registered server # [ 0.475319] usbcore: registered new interface driver usbfs server # [ 0.475580] usbcore: registered new interface driver hub server # [ 0.476488] usbcore: registered new device driver usb server # [ 0.478064] NetLabel: Initializing server # [ 0.478560] NetLabel: domain hash size = 128 server # [ 0.479401] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO server # [ 0.480420] NetLabel: unlabeled traffic allowed by default server # [ 0.481315] PCI: Using ACPI for IRQ routing server # [ 0.525654] pci 0000:00:01.0: vgaarb: setting as boot VGA device server # [ 0.526555] pci 0000:00:01.0: vgaarb: bridge control possible server # [ 0.526555] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none server # [ 0.526563] vgaarb: loaded server # [ 0.527338] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 server # [ 0.527561] hpet0: 3 comparators, 64-bit 100.000000 MHz counter server # [ 0.532647] clocksource: Switched to clocksource kvm-clock server # [ 0.535622] VFS: Disk quotas dquot_6.6.0 server # [ 0.536807] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) server # [ 0.538180] pnp: PnP ACPI init server # [ 0.538975] ACPI: IRQ 4 override to edge(!), high(!) server # [ 0.539918] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved server # [ 0.541485] pnp: PnP ACPI: found 5 devices server # [ 0.549051] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns server # [ 0.550580] clocksource: Switched to clocksource acpi_pm server # [ 0.551585] NET: Registered PF_INET protocol family server # [ 0.552665] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) server # [ 0.569183] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) server # [ 0.570748] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) server # [ 0.572072] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) server # [ 0.573401] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) server # [ 0.574664] TCP: Hash tables configured (established 8192 bind 8192) server # [ 0.575778] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) server # [ 0.577088] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) server # [ 0.578212] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) server # [ 0.579426] NET: Registered PF_UNIX/PF_LOCAL protocol family server # [ 0.580432] NET: Registered PF_XDP protocol family server # [ 0.581287] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] server # [ 0.582304] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] server # [ 0.583329] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] server # [ 0.584452] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] server # [ 0.585603] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] server # [ 0.586761] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] server # [ 0.588560] ACPI: \_SB_.GSIA: Enabled at IRQ 16 server # [ 0.591253] ACPI: \_SB_.GSIB: Enabled at IRQ 17 server # [ 0.593132] ACPI: \_SB_.GSIC: Enabled at IRQ 18 server # [ 0.594979] ACPI: \_SB_.GSID: Enabled at IRQ 19 server # [ 0.596563] PCI: CLS 0 bytes, default 64 server # [ 0.597456] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns server # [ 0.599213] Trying to unpack rootfs image as initramfs... server # [ 0.643057] Initialise system trusted keyrings server # [ 0.643985] Key type blacklist registered server # [ 0.646810] workingset: timestamp_bits=40 max_order=18 bucket_order=0 server # [ 0.649799] integrity: Platform Keyring initialized server # [ 0.650745] integrity: Machine keyring initialized server # [ 0.671080] Key type asymmetric registered server # [ 0.674816] Asymmetric key parser 'x509' registered server # [ 0.675717] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) server # [ 0.679775] io scheduler mq-deadline registered server # [ 0.680571] io scheduler kyber registered server # [ 0.684202] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled server # [ 0.685529] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A server # [ 0.689510] Linux agpgart interface v0.103 server # [ 0.690315] ACPI: bus type drm_connector registered server # [ 0.695145] usbcore: registered new interface driver usbserial_generic server # [ 0.696245] usbserial: USB Serial support registered for generic server # [ 0.699661] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. server # [ 0.699661] Please enable it if your BIOS has the CPPC option. server # [ 0.701945] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled server # [ 0.703379] drop_monitor: Initializing network drop monitor service server # [ 0.704563] NET: Registered PF_INET6 protocol family server # [ 0.708173] Segment Routing with IPv6 server # [ 0.711682] In-situ OAM (IOAM) with IPv6 server # [ 0.712836] IPI shorthand broadcast: enabled server # [ 0.721376] sched_clock: Marking stable (580018742, 140637591)->(794666727, -74010394) server # [ 0.726865] registered taskstats version 1 server # [ 0.727845] Loading compiled-in X.509 certificates server # [ 0.747243] Demotion targets for Node 0: null server # [ 0.748132] Key type .fscrypt registered server # [ 0.750664] Key type fscrypt-provisioning registered server # [ 0.751685] ima: No TPM chip found, activating TPM-bypass! server # [ 0.754677] ima: Allocated hash algorithm: sha1 server # [ 0.755527] ima: No architecture policies found server # [ 0.757663] PM: Magic number: 2:393:268 server # [ 0.759512] RAS: Correctable Errors collector initialized. server # [ 0.770766] clk: Disabling unused clocks server # [ 0.771496] PM: genpd: Disabling unused power domains server # [ 0.916038] Freeing initrd memory: 28264K server # [ 0.919265] Freeing unused decrypted memory: 2028K server # [ 0.923561] Freeing unused kernel image (initmem) memory: 6720K server # [ 0.924702] Write protecting the kernel read-only data: 32768k server # [ 0.926002] Freeing unused kernel image (text/rodata gap) memory: 232K server # [ 0.927490] Freeing unused kernel image (rodata/data gap) memory: 616K server # [ 0.977807] x86/mm: Checked W+X mappings: passed, no W+X pages found. server # [ 0.978927] Run /init as init process server # [ 0.988602] autofs4: module verification failed: signature and/or required key missing - tainting kernel server # [ 0.991118] systemd[1]: Inserted module 'autofs4' server # [ 1.010664] fuse: init (API version 7.45) server # [ 1.017741] ACPI: \_SB_.GSIG: Enabled at IRQ 22 server # [ 1.020272] ACPI: \_SB_.GSIH: Enabled at IRQ 23 server # [ 1.024213] ACPI: \_SB_.GSIE: Enabled at IRQ 20 server # [ 1.026224] ACPI: \_SB_.GSIF: Enabled at IRQ 21 server # [ 1.032310] virtiofs virtio5: discovered new tag: nix-store server # [ 1.033962] virtiofs virtio5: virtio_fs_setup_dax: No cache capability server # [ 1.041372] virtiofs virtio6: discovered new tag: shared server # [ 1.042987] virtiofs virtio6: virtio_fs_setup_dax: No cache capability server # [ 1.046593] virtiofs virtio7: discovered new tag: xchg server # [ 1.048169] virtiofs virtio7: virtio_fs_setup_dax: No cache capability server # [ 1.072455] systemd[1]: Successfully made /usr/ read-only. server # [ 1.409126] systemd[1]: systemd 262 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) server # [ 1.420826] systemd[1]: Detected virtualization kvm. server # [ 1.422941] systemd[1]: Detected architecture x86-64. server # [ 1.425043] systemd[1]: Running in initrd. server # [ 1.427499] systemd[1]: Initializing machine ID from random generator. server # [ 1.430546] systemd[1]: Hostname set to . server # [ 1.520057] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 1.555396] systemd[1]: Queued start job for default target Initrd Default Target. server # [ 1.559897] systemd[1]: Created slice Slice /system/modprobe. server # [ 1.561056] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. server # [ 1.562486] systemd[1]: Expecting device /dev/disk/by-label/nixos... server # [ 1.563653] systemd[1]: Reached target Path Units. server # [ 1.564523] systemd[1]: Reached target Slice Units. server # [ 1.565424] systemd[1]: Reached target Swaps. server # [ 1.566242] systemd[1]: Reached target Timer Units. server # [ 1.567239] systemd[1]: Listening on D-Bus System Message Bus Socket. server # [ 1.568465] systemd[1]: Listening on Journal Socket (/dev/log). server # [ 1.569685] systemd[1]: Listening on Journal Sockets. server # [ 1.570613] systemd[1]: Listening on udev Kernel Socket. server # [ 1.582943] systemd[1]: Listening on udev Varlink Socket. server # [ 1.583936] systemd[1]: Reached target Socket Units. server # [ 1.585805] systemd[1]: Starting Create List of Static Device Nodes... server # [ 1.590752] systemd[1]: Starting Load Kernel Module configfs... server # [ 1.599298] systemd[1]: Starting Journal Service... server # [ 1.608693] systemd[1]: Starting Load Kernel Modules... server # [ 1.611734] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 1.618368] systemd[1]: Starting Coldplug All udev Devices... server # [ 1.631976] systemd[1]: Finished Create List of Static Device Nodes. server # [ 1.635330] systemd[1]: modprobe@configfs.service: Deactivated successfully. server # [ 1.643025] systemd[1]: Finished Load Kernel Module configfs. server # [ 1.650084] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config server # [ 1.655215] systemd-journald[65]: Collecting audit messages is disabled. server # [ 1.660389] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... server # [ 1.670423] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. server # [ 1.680948] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev server # [ 1.700183] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. server # [ 1.708840] systemd[1]: Starting Create Static Device Nodes in /dev... server # [ 1.720182] systemd[1]: Finished Load Kernel Modules. server # [ 1.727904] systemd[1]: Starting Apply Kernel Variables... server # [ 1.747192] systemd[1]: Finished Create Static Device Nodes in /dev. server # [ 1.752847] systemd[1]: Reached target Preparation for Local File Systems. server # [ 1.758721] systemd[1]: Reached target Local File Systems. server # [ 1.764850] systemd[1]: Starting Rule-based Manager for Device Events and Files... server # [ 1.628546] systemd-modules-load[66]: Inserted module 'dm_mod' server # [ 1.632260] systemd-modules-load[66]: Inserted module 'virtio_balloon' server # [ 1.633381] systemd-modules-load[66]: Inserted module 'virtio_gpu' server # [ 1.777933] systemd[1]: Started Journal Service. server # [ 1.643904] systemd[1]: Finished Apply Kernel Variables. server # [ 1.655839] systemd[1]: Starting Create System Files and Directories... server # [ 1.683335] systemd[1]: Finished Create System Files and Directories. server # [ 1.688299] systemd-udevd[73]: Using default interface naming scheme 'v261'. server # [ 1.712066] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 1.766945] systemd[1]: Finished Coldplug All udev Devices. server # [ 1.767866] systemd[1]: Reached target System Initialization. server # [ 1.768822] systemd[1]: Reached target Basic System. server # [ 2.082466] virtio_blk virtio2: 1/0/0 default/read/poll queues server # [ 2.088402] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) server # [ 2.095890] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 server # [ 2.107841] serio: i8042 KBD port at 0x60,0x64 irq 1 server # [ 2.108535] serio: i8042 AUX port at 0x60,0x64 irq 12 server # [ 2.113071] ehci-pci 0000:00:1d.7: EHCI Host Controller server # [ 2.113795] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 server # [ 2.115026] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 server # [ 2.121800] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 server # [ 2.123378] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 server # [ 2.124674] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 server # [ 2.128840] usb usb1: Product: EHCI Host Controller server # [ 2.129512] usb usb1: Manufacturer: Linux 6.18.60 ehci_hcd server # [ 2.130662] usb usb1: SerialNumber: 0000:00:1d.7 server # [ 2.133729] hub 1-0:1.0: USB hub found server # [ 2.134300] hub 1-0:1.0: 6 ports detected server # [ 2.136993] uhci_hcd 0000:00:1d.0: UHCI Host Controller server # [ 2.137721] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 server # [ 2.147160] uhci_hcd 0000:00:1d.0: detected 2 ports server # [ 2.151512] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 server # [ 2.157496] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 server # [ 2.165203] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 server # [ 2.166256] usb usb2: Product: UHCI Host Controller server # [ 2.177092] usb usb2: Manufacturer: Linux 6.18.60 uhci_hcd server # [ 2.183495] SCSI subsystem initialized server # [ 2.185342] usb usb2: SerialNumber: 0000:00:1d.0 server # [ 2.194193] hub 2-0:1.0: USB hub found server # [ 2.195933] hub 2-0:1.0: 2 ports detected server # [ 2.060513] systemd[1]: Starting Virtual Console Setup... server # [ 2.077986] (udev-worker)[85]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. server # [ 2.231900] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 server # [ 2.095502] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line. server # [ 2.097468] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 2.241434] uhci_hcd 0000:00:1d.1: UHCI Host Controller server # [ 2.242177] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 server # [ 2.106071] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line. server # [ 2.107798] systemd[1]: Finished Virtual Console Setup. server # [ 2.259790] uhci_hcd 0000:00:1d.1: detected 2 ports server # [ 2.260613] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 server # [ 2.269777] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 server # [ 2.270929] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 server # [ 2.132087] systemd[1]: Found device /dev/disk/by-label/nixos. server # [ 2.133085] systemd[1]: Reached target Initrd Root Device. server # [ 2.136671] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... server # [ 2.293674] usb usb3: Product: UHCI Host Controller server # [ 2.294378] usb usb3: Manufacturer: Linux 6.18.60 uhci_hcd server # [ 2.296579] usb usb3: SerialNumber: 0000:00:1d.1 server # [ 2.299455] hub 3-0:1.0: USB hub found server # [ 2.300830] hub 3-0:1.0: 2 ports detected server # [ 2.167484] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks server # [ 2.310723] uhci_hcd 0000:00:1d.2: UHCI Host Controller server # [ 2.311447] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 server # [ 2.174643] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. server # [ 2.319143] uhci_hcd 0000:00:1d.2: detected 2 ports server # [ 2.320269] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 server # [ 2.322942] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 server # [ 2.325808] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 server # [ 2.327698] usb usb4: Product: UHCI Host Controller server # [ 2.328439] usb usb4: Manufacturer: Linux 6.18.60 uhci_hcd server # [ 2.331364] usb usb4: SerialNumber: 0000:00:1d.2 server # [ 2.338206] hub 4-0:1.0: USB hub found server # [ 2.339332] hub 4-0:1.0: 2 ports detected server # [ 2.367905] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode server # [ 2.371368] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) server # [ 2.372668] ahci 0000:00:1f.2: flags: 64bit ncq only server # [ 2.376579] scsi host0: ahci server # [ 2.377101] usb 1-1: new high-speed USB device number 2 using ehci-pci server # [ 2.378267] scsi host1: ahci server # [ 2.380743] scsi host2: ahci server # [ 2.382386] scsi host3: ahci server # [ 2.384042] scsi host4: ahci server # [ 2.385898] scsi host5: ahci server # [ 2.386495] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 server # [ 2.388665] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 server # [ 2.389812] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 server # [ 2.390981] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 server # [ 2.392161] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 server # [ 2.393318] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 server # [ 2.507298] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 server # [ 2.510372] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 server # [ 2.514312] usb 1-1: Product: QEMU USB Tablet server # [ 2.516392] usb 1-1: Manufacturer: QEMU server # [ 2.518460] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 server # [ 2.553944] hid: raw HID events driver (C) Jiri Kosina server # [ 2.488992] systemd[1]: Mounting /sysroot... server # [ 2.704006] ata4: SATA link down (SStatus 0 SControl 300) server # [ 2.705202] ata1: SATA link down (SStatus 0 SControl 300) server # [ 2.708172] ata6: SATA link down (SStatus 0 SControl 300) server # [ 2.710786] ata2: SATA link down (SStatus 0 SControl 300) server # [ 2.713268] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) server # [ 2.716201] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 server # [ 2.718623] ata3.00: applying bridge limits server # [ 2.720891] ata5: SATA link down (SStatus 0 SControl 300) server # [ 2.723170] ata3.00: configured for UDMA/100 server # [ 2.726761] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 server # [ 2.791334] usbcore: registered new interface driver usbhid server # [ 2.795846] usbhid: USB HID core driver server # [ 2.818062] 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/input2 server # [ 2.821684] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 server # [ 2.824905] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray server # [ 2.834812] cdrom: Uniform CD-ROM driver Revision: 3.20 server # [ 2.839721] EXT4-fs (vda): mounted filesystem eaac7a8b-9b03-4e1e-966d-a7c1f48c7cff r/w with ordered data mode. Quota mode: none. server # [ 2.705041] systemd[1]: Mounted /sysroot. server # [ 2.708858] systemd[1]: Reached target Initrd Root File System. server # [ 2.710832] systemd[1]: Starting Mountpoints Configured in the Real Root... server # [ 2.727754] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload. server # [ 2.730636] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)... server # [ 2.732144] systemd[1]: Reloading... server # [ 2.807839] systemd[1]: Reloading finished in 74 ms. server # [ 2.816599] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace... server # [ 2.821179] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace... server # [ 2.823914] systemd[1]: initrd-parse-etc.service: Deactivated successfully. server # [ 2.825285] systemd[1]: Finished Mountpoints Configured in the Real Root. server # [ 2.827159] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. server # [ 3.490533] systemd[1]: Mounting /sysroot/nix/.ro-store... server # [ 3.493171] systemd[1]: Mounting /sysroot/nix/.rw-store... server # [ 3.498134] systemd[1]: Mounting /sysroot/run... server # [ 3.502136] systemd[1]: Mounting /sysroot/tmp/shared... server # [ 3.505139] systemd[1]: Mounting /sysroot/tmp/xchg... server # [ 3.530609] systemd[1]: Mounted /sysroot/nix/.rw-store. server # [ 3.532645] systemd[1]: Mounted /sysroot/nix/.ro-store. server # [ 3.540322] systemd[1]: Mounted /sysroot/run. server # [ 3.542663] systemd[1]: Mounted /sysroot/tmp/xchg. server # [ 3.544090] systemd[1]: Mounted /sysroot/tmp/shared. server # [ 3.547864] systemd[1]: Starting rw-sysroot-nix-store.service... server # [ 3.558493] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. server # [ 3.559963] systemd[1]: Finished rw-sysroot-nix-store.service. server # [ 4.491378] systemd[1]: Mounting /sysroot/nix/store... server # [ 4.539565] systemd[1]: Mounted /sysroot/nix/store. server # [ 4.543154] systemd[1]: Reached target Initrd File Systems. server # [ 4.545970] systemd[1]: Starting Find NixOS closure... server # [ 4.551258] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... server # [ 4.575848] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. server # [ 4.577564] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. server # [ 4.585736] systemd[1]: Finished Find NixOS closure. server # [ 4.587323] systemd[1]: Reached target Initrd Default Target. server # [ 4.589415] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... server # [ 4.602841] systemd[1]: Stopped target Initrd Default Target. server # [ 4.603883] systemd[1]: Stopped target Basic System. server # [ 4.604835] systemd[1]: Stopped target Initrd Root Device. server # [ 4.605927] systemd[1]: Stopped target Path Units. server # [ 4.607105] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. server # [ 4.608344] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. server # [ 4.609790] systemd[1]: Stopped target Slice Units. server # [ 4.610824] systemd[1]: Stopped target Socket Units. server # [ 4.612133] systemd[1]: Stopped target System Initialization. server # [ 4.613225] systemd[1]: Stopped target Swaps. server # [ 4.614125] systemd[1]: Stopped target Timer Units. server # [ 4.614972] systemd[1]: dbus.socket: Deactivated successfully. server # [ 4.617052] systemd[1]: Closed D-Bus System Message Bus Socket. server # [ 4.617900] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. server # [ 4.619054] systemd[1]: Stopped Find NixOS closure. server # [ 4.620100] systemd[1]: Starting rw-sysroot-nix-store.service... server # [ 4.623070] systemd[1]: systemd-sysctl.service: Deactivated successfully. server # [ 4.624136] systemd[1]: Stopped Apply Kernel Variables. server # [ 4.624871] systemd[1]: systemd-modules-load.service: Deactivated successfully. server # [ 4.625996] systemd[1]: Stopped Load Kernel Modules. server # [ 4.626897] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. server # [ 4.628079] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. server # [ 4.629176] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. server # [ 4.631095] systemd[1]: Stopped Create System Files and Directories. server # [ 4.631993] systemd[1]: Stopped target Local File Systems. server # [ 4.632854] systemd[1]: Stopped target Preparation for Local File Systems. server # [ 4.633866] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. server # [ 4.635115] systemd[1]: Stopped Coldplug All udev Devices. server # [ 4.637111] systemd[1]: Stopping Rule-based Manager for Device Events and Files... server # [ 4.638205] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 4.639902] systemd[1]: Stopped Virtual Console Setup. server # [ 4.647825] systemd[1]: initrd-cleanup.service: Deactivated successfully. server # [ 4.652168] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. server # [ 4.655148] systemd[1]: systemd-udevd.service: Deactivated successfully. server # [ 4.657807] systemd[1]: Stopped Rule-based Manager for Device Events and Files. server # [ 4.661087] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. server # [ 4.663094] systemd[1]: Closed udev Varlink Socket. server # [ 4.664982] systemd[1]: Starting Cleanup udev Database... server # [ 4.666174] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. server # [ 4.667319] systemd[1]: Stopped Create Static Device Nodes in /dev. server # [ 4.669138] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. server # [ 4.670265] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. server # [ 4.671421] systemd[1]: kmod-static-nodes.service: Deactivated successfully. server # [ 4.672480] systemd[1]: Stopped Create List of Static Device Nodes. server # [ 4.673827] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. server # [ 4.676143] systemd[1]: Finished rw-sysroot-nix-store.service. server # [ 4.692264] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. server # [ 4.693751] systemd[1]: Finished Cleanup udev Database. server # [ 4.696109] systemd[1]: Reached target Switch Root. server # [ 4.697151] systemd[1]: Starting NixOS Activation... server # [ 4.773538] initrd-nixos-activation-start[190]: booting system configuration /nix/store/9ij3wqhfccmkcrsrfk94hqyq0rkfgyis-nixos-system-server-test server # [ 4.801324] initrd-nixos-activation-start[190]: running activation script... server # [ 5.017743] initrd-nixos-activation-start[213]: setting up /etc... server # [ 5.126552] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. server # [ 5.129082] systemd[1]: Finished NixOS Activation. server # [ 5.130223] systemd[1]: Starting Switch Root... server # [ 5.141969] systemd[1]: Switching root. server # [ 5.408692] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). server # [ 5.484216] NET: Registered PF_VSOCK protocol family server # [ 5.844040] systemd[1]: systemd 262 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) server # [ 5.853799] systemd[1]: Detected virtualization kvm. server # [ 5.855576] systemd[1]: Detected architecture x86-64. server # [ 5.857532] systemd[1]: Detected first boot. server # [ 5.861351] systemd[1]: Initializing machine ID from random generator. server # [ 5.966983] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 6.052279] systemd[1]: Applying preset policy. server # [ 6.230551] systemd[1]: Populated /etc with preset unit settings. server # [ 6.429563] systemd[1]: initrd-switch-root.service: Deactivated successfully. server # [ 6.430947] systemd[1]: Stopped initrd-switch-root.service. server # [ 6.433017] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. server # [ 6.435112] systemd[1]: Created slice Slice /system/getty. server # [ 6.436386] systemd[1]: Created slice User and Session Slice. server # [ 6.437333] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. server # [ 6.438556] systemd[1]: Started Forward Password Requests to Wall Directory Watch. server # [ 6.439692] systemd[1]: Expecting device /dev/hvc0... server # [ 6.440412] systemd[1]: Expecting device /dev/ttyS0... server # [ 6.441215] systemd[1]: Reached target Local Encrypted Volumes. server # [ 6.442025] systemd[1]: Stopped target initrd-fs.target. server # [ 6.442853] systemd[1]: Stopped target initrd-root-fs.target. server # [ 6.443693] systemd[1]: Stopped target initrd-switch-root.target. server # [ 6.456073] systemd[1]: Reached target Virtual Machines and Containers. server # [ 6.456983] systemd[1]: Reached target Path Units. server # [ 6.457693] systemd[1]: Reached target Remote File Systems. server # [ 6.458508] systemd[1]: Reached target Slice Units. server # [ 6.459279] systemd[1]: Reached target Swaps. server # [ 6.461057] systemd[1]: Listening on Query the User Interactively for a Password. server # [ 6.463427] systemd[1]: Listening on Process Core Dump Socket. server # [ 6.465280] systemd[1]: Listening on Credential Encryption/Decryption. server # [ 6.467066] systemd[1]: Listening on Factory Reset Management. server # [ 6.467993] systemd[1]: Listening on Hostname Service Socket. server # [ 6.470554] systemd[1]: Starting Journal Log Access Socket... server # [ 6.472011] systemd[1]: Listening on Journal Audit Socket. server # [ 6.475151] systemd[1]: Listening on Console Output Muting Service Socket. server # [ 6.476233] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. server # [ 6.477373] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os server # [ 6.478700] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki server # [ 6.482727] systemd[1]: Listening on Disk Repartitioning Service Socket. server # [ 6.483791] systemd[1]: Listening on udev Varlink Socket. server # [ 6.485980] systemd[1]: Mounting Huge Pages File System... server # [ 6.488244] systemd[1]: Mounting POSIX Message Queue File System... server # [ 6.494790] systemd[1]: Mounting Kernel Debug File System... server # [ 6.501370] systemd[1]: Mounting Kernel Trace File System... server # [ 6.511040] systemd[1]: Starting Create List of Static Device Nodes... server # [ 6.521296] systemd[1]: Starting Load Kernel Module configfs... server # [ 6.529967] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm server # [ 6.535859] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore server # [ 6.544966] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse server # [ 6.560907] systemd[1]: Mounting FUSE Control File System... server # [ 6.566059] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 server # [ 6.573279] systemd[1]: Starting Journal Service... server # [ 6.584781] systemd[1]: Starting Load Kernel Modules... server # [ 6.594442] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... server # [ 6.606491] systemd[1]: Starting Remount Root and Kernel File Systems... server # [ 6.611312] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 6.622768] systemd[1]: Starting Coldplug All udev Devices... server # [ 6.632404] systemd[1]: Listening on Journal Log Access Socket. server # [ 6.634377] systemd[1]: Mounted Huge Pages File System. server # [ 6.639854] systemd[1]: Mounted POSIX Message Queue File System. server # [ 6.647958] systemd[1]: Mounted Kernel Debug File System. server # [ 6.651240] systemd[1]: Mounted Kernel Trace File System. server # [ 6.654406] systemd-journald[284]: Collecting audit messages is enabled. server # [ 6.655729] systemd[1]: Finished Create List of Static Device Nodes. server # [ 6.661309] systemd[1]: modprobe@configfs.service: Deactivated successfully. server # [ 6.667809] systemd[1]: Finished Load Kernel Module configfs. server # [ 6.674850] loop: module loaded server # [ 6.682494] systemd[1]: Mounting Kernel Configuration File System... server # [ 6.687880] EXT4-fs (vda): re-mounted eaac7a8b-9b03-4e1e-966d-a7c1f48c7cff. server # [ 6.551331] systemd[1]: Queued start job for default target Multi-User System. server # [ 6.552831] systemd[1]: systemd-journald.service: Deactivated successfully. server # [ 6.694705] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... server # [ 6.555608] systemd-modules-load[285]: Inserted module 'loop' server # [ 6.700460] systemd[1]: Started Journal Service. server # [ 6.563768] systemd[1]: Mounted FUSE Control File System. server # [ 6.571762] systemd[1]: Finished Load Kernel Modules. server # [ 6.574954] systemd[1]: Finished Remount Root and Kernel File Systems. server # [ 6.596634] systemd-oomd[286]: No swap; memory pressure usage will be degraded server # [ 6.600124] systemd[1]: Listening on Disk Image Download Service Socket. server # [ 6.604251] systemd[1]: Starting Firewall... server # [ 6.610061] systemd[1]: Starting Flush Journal to Persistent Storage... server # [ 6.612054] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore server # [ 6.615076] systemd[1]: Starting Load/Save OS Random Seed... server # [ 6.630880] systemd[1]: Starting Apply Kernel Variables... server # [ 6.631707] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 6.632855] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. server # [ 6.839761] systemd-journald[284]: Received client request to flush runtime journal. server # [ 6.797695] systemd[1]: Finished Load/Save OS Random Seed. server # [ 6.799888] systemd[1]: Mounted Kernel Configuration File System. server # [ 6.802180] systemd[1]: Reached target First Boot Complete. server # [ 6.802981] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. server # [ 6.804469] systemd[1]: Starting Create Static Device Nodes in /dev... server # [ 6.805886] systemd[1]: Finished Apply Kernel Variables. server # [ 6.809132] systemd[1]: Finished Flush Journal to Persistent Storage. server # [ 6.895195] systemd[1]: Finished Create Static Device Nodes in /dev. server # [ 6.897163] systemd[1]: Reached target Preparation for Local File Systems. server # [ 6.900464] systemd[1]: Starting Rule-based Manager for Device Events and Files... server # [ 6.906503] systemd[1]: Finished Coldplug All udev Devices. server # [ 6.954330] systemd-udevd[321]: Using default interface naming scheme 'v261'. server # [ 7.007197] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 7.118066] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse server # [ 7.198257] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. server # [ 7.226327] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. server # [ 7.257969] (udev-worker)[354]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. server # [ 7.262751] (udev-worker)[354]: Network interface NamePolicy= disabled on kernel command line. server # [ 7.265649] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line. server # [ 7.296906] systemd[1]: Mounting /run/wrappers... server # [ 7.332166] systemd[1]: Mounted /run/wrappers. server # [ 7.333943] systemd[1]: Reached target Local File Systems. server # [ 7.337432] systemd[1]: Listening on Boot Loader Control Service Socket. server # [ 7.342107] systemd[1]: Starting register-nix-paths.service... server # [ 7.345305] systemd[1]: Starting Create SUID/SGID Wrappers... server # [ 7.347166] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. server # [ 7.355658] systemd[1]: Starting Save Transient machine-id to Disk... server # [ 7.361133] systemd[1]: Starting Create System Files and Directories... server # [ 7.457313] systemd[1]: Condition check resulted in Virtio network device being skipped. server # [ 7.461200] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore server # [ 7.463331] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. server # [ 7.465513] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 server # [ 7.467788] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore server # [ 7.471164] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 7.473266] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 7.475545] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. server # [ 7.479099] systemd[1]: Finished Save Transient machine-id to Disk. server # [ 7.516504] systemd[1]: Finished Create System Files and Directories. server # [ 7.525048] systemd[1]: Starting Rebuild Journal Catalog... server # [ 7.529178] systemd[1]: Starting Record System Boot/Shutdown in UTMP... server # [ 7.616088] systemd[1]: Finished Record System Boot/Shutdown in UTMP. server # [ 7.653138] systemd[1]: Finished Rebuild Journal Catalog. server # [ 7.660234] systemd[1]: Starting Update is Completed... server # [ 7.865438] input: Power Button as /devices/platform/LNXPWRBN:00/input/input3 server # [ 7.736148] systemd[1]: Finished Update is Completed. server # [ 7.897533] mousedev: PS/2 mouse device common for all mice server # [ 7.921320] ACPI: button: Power Button [PWRF] server # [ 7.956312] rtc_cmos PNP0B00:00: RTC can wake from S4 server # [ 7.973556] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console server # [ 7.997959] parport_pc 00:02: reported by Plug and Play ACPI server # [ 7.999163] rtc_cmos PNP0B00:00: registered as rtc0 server # [ 7.995293] systemd[1]: Finished Firewall. server # [ 8.046747] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. server # [ 8.051492] systemd[1]: Finished Create SUID/SGID Wrappers. server # [ 8.020816] rtc_cmos PNP0B00:00: setting system clock to 2026-11-12T07:15:22 UTC (1794467722) server # [ 8.020906] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs server # [ 8.023163] systemd-journald[284]: Time jumped backwards, rotating. server # [ 8.046017] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 server # [ 8.103144] systemd[1]: Finished register-nix-paths.service. server # [ 8.103938] systemd[1]: Reached target System Initialization. server # [ 8.106086] systemd[1]: Started Discard unused filesystem blocks once a week. server # [ 8.107188] systemd[1]: Started niks3 garbage collection timer. server # [ 8.108044] systemd[1]: Started Daily Cleanup of Temporary Directories. server # [ 8.108934] systemd[1]: Reached target Timer Units. server # [ 8.109671] systemd[1]: Listening on D-Bus System Message Bus Socket. server # [ 8.115633] systemd[1]: Listening on niks3 server socket. server # [ 8.116440] systemd[1]: Listening on Nix Daemon Socket. server # [ 8.117235] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. server # [ 8.118454] systemd[1]: Reached target Socket Units. server # [ 8.119212] systemd[1]: Reached target Basic System. server # [ 8.121262] systemd[1]: Started backdoor.service. server # [ 8.124145] systemd[1]: Starting Import lastlog data into lastlog2 database... server # [ 8.132761] systemd[1]: Starting Name Service Cache Daemon (nsncd)... server # [ 8.144242] systemd[1]: Started openbao-dev.service. server # [ 8.052760] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] server # [ 8.085549] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized server # [ 8.228201] Console: switching to colour dummy device 80x25 server # [ 8.231408] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt server # [ 8.154253] systemd[1]: Starting openbao-setup.service... server # [ 8.179527] systemd[1]: Starting Post-Boot Actions... server # [ 8.185883] systemd[1]: Started Reset console on configuration changes. server # [ 8.200187] systemd[1]: Starting resolvconf update... server # [ 8.231517] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD server # [ 8.316675] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 server # [ 8.236592] nsncd[511]: Nov 12 07:15:22.855 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # [ 8.245883] systemd[1]: Started Name Service Cache Daemon (nsncd). server # connecting to host... server # [ 8.266379] systemd[1]: Reached target Host and Network Name Lookups. server # [ 8.274085] systemd[1]: Reached target User and Group Name Lookups. server # [ 8.294361] systemd[1]: Starting D-Bus System Message Bus... [9.20s] server: Guest shell says: b'Spawning backdoor root shell...\n' server # [ 8.311285] systemd[1]: Starting User Login Management... server # [ 8.317051] systemd[1]: Finished Post-Boot Actions. [9.21s] server: connected to guest root shell server # [ 8.317008] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 [9.21s] server: (connecting took 9.02 seconds) [9.21s] server: (finished: waiting for the VM to finish booting, in 9.21 seconds) server # [ 8.350075] systemd[1]: Finished Import lastlog data into lastlog2 database. server # [ 8.505762] [drm] Found bochs VGA, ID 0xb0c5. server # [ 8.506243] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. server # [ 8.389474] systemd[1]: Starting Virtual Console Setup... server # [ 8.584466] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic server # [ 8.627370] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 server # [ 8.518567] dbus-broker-launch[542]: Looking up NSS user entry for 'systemd-timesync'... server # [ 8.523630] dbus-broker-launch[542]: NSS returned no entry for 'systemd-timesync' server # [ 8.525078] dbus-broker-launch[542]: Invalid user-name in /nix/store/qndp67d2f715bzvmfqbkn8cn0la019i5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" server # [ 8.577595] systemd-logind[543]: Watching system buttons on /dev/input/event2 (Power Button) server # [ 8.582741] systemd-logind[543]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) server # [ 8.584038] systemd-logind[543]: New seat seat0. server # [ 8.588332] systemd[1]: Started D-Bus System Message Bus. server # [ 8.589980] systemd[1]: Started User Login Management. server # [ 8.599068] systemd[1]: Starting linger-users.service... server # [ 8.605772] systemd[1]: Stopped target Host and Network Name Lookups. server # [ 8.608191] systemd[1]: Stopping Host and Network Name Lookups... server # [ 8.610277] systemd[1]: Stopped target User and Group Name Lookups. server # [ 8.611728] systemd[1]: Stopping User and Group Name Lookups... server # [ 8.614126] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... server # [ 8.623315] systemd[1]: nscd.service: Deactivated successfully. server # [ 8.629782] systemd[1]: Stopped Name Service Cache Daemon (nsncd). server # [ 8.636449] dbus-broker-launch[542]: Ready server # [ 8.925903] ppdev: user-space parallel port driver server # [ 8.967395] Console: switching to colour frame buffer device 160x50 server # [ 8.969989] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device server # [ 8.679943] systemd[1]: Starting Name Service Cache Daemon (nsncd)... server # [ 8.831512] systemd[1]: linger-users.service: Deactivated successfully. server # [ 8.832605] systemd[1]: Finished linger-users.service. server # [ 8.833470] systemd[1]: Started Name Service Cache Daemon (nsncd). server # [ 8.835892] nsncd[617]: Nov 12 07:15:23.384 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # [ 8.841383] systemd[1]: Reached target Host and Network Name Lookups. server # [ 8.845563] systemd[1]: Reached target User and Group Name Lookups. server # [ 8.846595] systemd[1]: Finished resolvconf update. server # [ 8.847293] systemd[1]: Reached target Preparation for Network. server # [ 8.848085] systemd[1]: Starting DHCP Client... server # [ 8.848768] systemd[1]: Starting Address configuration of eth1... server # [ 8.849620] systemd[1]: Starting Extra networking commands.... server # [ 8.853749] systemd-logind[543]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) server # [ 8.855137] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 8.863456] systemd[1]: Stopped Virtual Console Setup. server # [ 8.893526] systemd[1]: Starting Virtual Console Setup... server # [ 9.109569] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) server # [ 9.046983] network-addresses-eth1-start[641]: adding address 192.168.1.1/24... done server # [ 9.197792] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) server # [ 9.080059] network-addresses-eth1-start[641]: adding address 2001:db8:1::1/64... done server # [ 9.118486] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 9.119502] systemd[1]: Stopped Virtual Console Setup. server # [ 9.140065] systemd[1]: Starting Virtual Console Setup... server # [ 9.164378] systemd[1]: Finished Address configuration of eth1. server # [ 9.266383] dhcpcd[655]: dhcpcd-10.3.2 starting server # [ 9.311407] dhcpcd[710]: dev: loaded udev server # [ 9.333254] systemd[1]: Finished Extra networking commands.. server # [ 9.337589] systemd[1]: Reached target Network. server # [ 9.342967] systemd[1]: Starting PostgreSQL Server... server # [ 9.347555] systemd[1]: Started RustFS S3-compatible object storage. server # [ 9.353089] bao[512]: 2026-11-12T07:15:23.971Z [INFO] proxy environment: http_proxy="" https_proxy="" no_proxy="" server # [ 9.503887] 8021q: 802.1Q VLAN Support v1.8 server # [ 9.504343] 8021q: adding VLAN 0 to HW filter on device eth1 server # [ 9.373540] systemd[1]: Starting Setup RustFS bucket... server # [ 9.379537] bao[512]: 2026-11-12T07:15:23.999Z [WARN] no `api_addr` value specified in config or in BAO_API_ADDR; falling back to detection if possible, but this value should be manually set server # [ 9.386193] systemd[1]: Starting Permit User Sessions... server # [ 9.399755] bao[512]: 2026-11-12T07:15:24.018Z [INFO] core: Initializing version history cache for core server # [ 9.400922] bao[512]: ==> OpenBao server configuration: server # [ 9.401626] bao[512]: Api Address: http://127.0.0.1:8200 server # [ 9.403168] bao[512]: Cgo: enabled server # [ 9.403901] bao[512]: Cluster Address: https://127.0.0.1:8201[ 9.545714] kvm_amd: TSC scaling supported server # [ 9.546155] kvm_amd: Nested Virtualization enabled server # [ 9.546592] kvm_amd: Nested Paging enabled server # [ 9.546990] kvm_amd: LBR virtualization supported server # [ 9.547451] kvm_amd: Virtual VMLOAD VMSAVE supported server # server # [ 9.407440] bao[512]: Environment Variables: HOME, INVOCATION_ID, IO_PRESSURE_WATCH, IO_PRESSURE_WRITE, JOURNAL_STREAM, LANG, LOCALE_ARCHIVE, LOGNAME, MEMORY_PRESSURE_WATCH, MEMORY_PRESSURE_WRITE, PATH, RUNTIME_DIRECTORY, STATE_DIRECTORY, SYSTEMD_EXEC_PID, TZDIR, USER server # [ 9.411117] bao[512]: Go Version: go1.27.3 server # [ 9.411799] bao[512]: Listener 1: tcp (addr: "127.0.0.1:8200", cluster address: "127.0.0.1:8201", max_request_duration: "1m30s", max_request_json_memory: "34078720", max_request_json_strings: "1000", max_request_size: "33554432", tls: "disabled") server # [ 9.414456] bao[512]: Log Level: server # [ 9.415087] bao[512]: Recovery Mode: false server # [ 9.415764] bao[512]: Storage: inmem server # [ 9.416464] bao[512]: Version: OpenBao v2.7.2, committed 1970-01-01T00:00:00Z server # [ 9.417588] bao[512]: Version Sha: refs/tags/v2.7.2 server # [ 9.421234] bao[512]: 2026-11-12T07:15:24.040Z [INFO] core: security barrier not initialized server # [ 9.423523] bao[512]: 2026-11-12T07:15:24.042Z [INFO] core: security barrier initialized: shares=1 threshold=1 server # [ 9.566359] kvm_amd: Virtual GIF supported server # [ 9.566781] kvm_amd: Virtual NMI enabled server # [ 9.428460] bao[512]: 2026-11-12T07:15:24.048Z [INFO] core: post-unseal setup starting server # [ 9.483513] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. server # [ 9.497171] bao[512]: 2026-11-12T07:15:24.116Z [INFO] core: loaded wrapping token key server # [ 9.507055] bao[512]: 2026-11-12T07:15:24.124Z [INFO] core: successfully setup plugin catalog: plugin-directory="" server # [ 9.520151] systemd[1]: Finished Permit User Sessions. server # [ 9.525768] bao[512]: 2026-11-12T07:15:24.145Z [INFO] core: reading transactional mount table server # [ 9.526949] bao[512]: 2026-11-12T07:15:24.145Z [INFO] core: no mounts in transactional mount table; adding default mount table server # [ 9.533309] systemd[1]: Started Getty on tty1. server # [ 9.536204] systemd[1]: Reached target Login Prompts. server # [ 9.693242] EDAC MC: Ver: 3.0.0 server # [ 9.554856] bao[512]: 2026-11-12T07:15:24.174Z [INFO] core: successfully mounted: type=cubbyhole version="v2.7.2+builtin.bao" path=cubbyhole/ namespace="ID: root. Path: " server # [ 9.580062] bao[512]: 2026-11-12T07:15:24.198Z [INFO] core: successfully mounted: type=system version="v2.7.2+builtin.bao" path=sys/ namespace="ID: root. Path: " server # [ 9.590314] bao[512]: 2026-11-12T07:15:24.208Z [INFO] core: successfully mounted: type=identity version="v2.7.2+builtin.bao" path=identity/ namespace="ID: root. Path: " server # [ 9.592153] bao[512]: 2026-11-12T07:15:24.209Z [INFO] core: reading transactional auth mount table server # [ 9.599261] bao[512]: 2026-11-12T07:15:24.217Z [INFO] core: no auth mounts in transactional auth mount table; adding default auth mount table server # [ 9.607766] bao[512]: 2026-11-12T07:15:24.226Z [INFO] core: successfully mounted: type=token version="v2.7.2+builtin.bao" path=token/ namespace="ID: root. Path: " server # [ 9.609549] bao[512]: 2026-11-12T07:15:24.227Z [INFO] rollback: Starting the rollback manager with 256 workers server # [ 9.620247] bao[512]: 2026-11-12T07:15:24.239Z [INFO] core: restoring leases server # [ 9.627236] bao[512]: 2026-11-12T07:15:24.246Z [INFO] rollback: starting rollback manager server # [ 9.633071] bao[512]: 2026-11-12T07:15:24.250Z [INFO] expiration: lease restore complete server # [ 9.652489] bao[512]: 2026-11-12T07:15:24.271Z [INFO] core: entities restored server # [ 9.653443] bao[512]: 2026-11-12T07:15:24.271Z [INFO] core: groups restored server # [ 9.654362] bao[512]: 2026-11-12T07:15:24.272Z [INFO] core: Recorded vault version: vault version=2.7.2 upgrade time="2026-11-12 07:15:24.271754789 +0000 UTC" commit date=1970-01-01T00:00:00Z server # [ 9.670826] bao[512]: 2026-11-12T07:15:24.290Z [INFO] core: post-unseal setup complete server # [ 9.680528] bao[512]: 2026-11-12T07:15:24.299Z [INFO] core: root token generated server # [ 9.681474] bao[512]: 2026-11-12T07:15:24.299Z [INFO] core: pre-seal teardown starting server # [ 9.687829] bao[512]: 2026-11-12T07:15:24.307Z [INFO] rollback: stopping rollback manager server # [ 9.694301] bao[512]: 2026-11-12T07:15:24.313Z [INFO] core: pre-seal teardown complete server # [ 9.703755] bao[512]: 2026-11-12T07:15:24.322Z [INFO] core.cluster-listener.tcp: starting listener: listener_address=127.0.0.1:8201 server # [ 9.705201] bao[512]: 2026-11-12T07:15:24.323Z [INFO] core.cluster-listener: serving cluster requests: cluster_listen_address=127.0.0.1:8201 server # [ 9.707059] bao[512]: 2026-11-12T07:15:24.326Z [INFO] core: post-unseal setup starting server # [ 9.711404] bao[512]: 2026-11-12T07:15:24.330Z [INFO] core: loaded wrapping token key server # [ 9.712544] bao[512]: 2026-11-12T07:15:24.330Z [INFO] core: successfully setup plugin catalog: plugin-directory="" server # [ 9.717347] bao[512]: 2026-11-12T07:15:24.334Z [INFO] core: reading transactional mount table server # [ 9.720652] bao[512]: 2026-11-12T07:15:24.340Z [INFO] core: successfully mounted: type=system version="v2.7.2+builtin.bao" path=sys/ namespace="ID: root. Path: " server # [ 9.726809] bao[512]: 2026-11-12T07:15:24.346Z [INFO] core: successfully mounted: type=identity version="v2.7.2+builtin.bao" path=identity/ namespace="ID: root. Path: " server # [ 9.730387] bao[512]: 2026-11-12T07:15:24.349Z [INFO] core: successfully mounted: type=cubbyhole version="v2.7.2+builtin.bao" path=cubbyhole/ namespace="ID: root. Path: " server # [ 9.737876] bao[512]: 2026-11-12T07:15:24.357Z [INFO] core: reading transactional auth mount table server # [ 9.740168] bao[512]: 2026-11-12T07:15:24.359Z [INFO] core: successfully mounted: type=token version="v2.7.2+builtin.bao" path=token/ namespace="ID: root. Path: " server # [ 9.746208] bao[512]: 2026-11-12T07:15:24.364Z [INFO] rollback: Starting the rollback manager with 256 workers server # [ 9.747492] bao[512]: 2026-11-12T07:15:24.365Z [INFO] core: restoring leases server # [ 9.758822] bao[512]: 2026-11-12T07:15:24.377Z [INFO] expiration: lease restore complete server # [ 9.767761] bao[512]: 2026-11-12T07:15:24.387Z [INFO] rollback: starting rollback manager server # [ 9.776205] bao[512]: 2026-11-12T07:15:24.392Z [INFO] core: entities restored server # [ 9.779385] bao[512]: 2026-11-12T07:15:24.397Z [INFO] core: groups restored server # [ 9.780690] bao[512]: 2026-11-12T07:15:24.400Z [INFO] core: post-unseal setup complete server # [ 9.785026] bao[512]: 2026-11-12T07:15:24.402Z [INFO] core: vault is unsealed server # [ 9.928566] cfg80211: Loading compiled-in X.509 certificates for regulatory database server # [ 9.941150] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' server # [ 9.941864] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' server # [ 9.948472] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 server # [ 9.949341] cfg80211: failed to load regulatory.db server # [ 9.835892] bao[512]: 2026-11-12T07:15:24.455Z [INFO] expiration: revoked lease: lease_id=auth/token/root/h06d47296ff2cf5e893a821cfa6f826bfe20e1bf60b37121a91f516ce690be7bd server # [ 9.874945] bao[512]: 2026-11-12T07:15:24.493Z [INFO] core: successful mount: namespace="" path=secret/ type=kv version="" server # [ 9.876426] bao[512]: 2026-11-12T07:15:24.494Z [INFO] beginning post-unseal configuration server # [ 9.877471] bao[512]: ==> OpenBao server started! server # [ 9.881537] bao[512]: 2026-11-12T07:15:24.500Z [INFO] secrets.kv.kv_59479065: collecting keys to upgrade server # [ 9.882719] bao[512]: 2026-11-12T07:15:24.500Z [INFO] secrets.kv.kv_59479065: done collecting keys: num_keys=1 server # [ 9.884056] bao[512]: 2026-11-12T07:15:24.500Z [INFO] secrets.kv.kv_59479065: upgrading keys finished server # [ 10.073866] 8021q: adding VLAN 0 to HW filter on device eth0 server # [ 9.935466] dhcpcd[710]: eth0: waiting for carrier server # [ 9.936187] dhcpcd[710]: eth0: carrier acquired server # [ 9.950666] dhcpcd[710]: DUID 00:01:00:01:32:88:24:0c:52:54:00:12:34:56 server # [ 9.951931] dhcpcd[710]: eth0: IAID 00:12:34:56 server # [ 9.952745] dhcpcd[710]: eth0: adding address fe80::5054:ff:fe12:3456 server # [ 9.956259] postgresql-pre-start[742]: The files belonging to this database system will be owned by user "postgres". server # [ 9.958234] postgresql-pre-start[742]: This user must also own the server process. server # [ 9.967378] postgresql-pre-start[742]: The database cluster will be initialized with locale "en_US.UTF-8". server # [ 9.968587] postgresql-pre-start[742]: The default database encoding has accordingly been set to "UTF8". server # [ 9.969734] postgresql-pre-start[742]: The default text search configuration will be set to "english". server # [ 9.970841] postgresql-pre-start[742]: Data page checksums are enabled. server # [ 9.971819] postgresql-pre-start[742]: fixing permissions on existing directory /var/lib/postgresql/18 ... ok server # [ 9.973282] postgresql-pre-start[742]: creating subdirectories ... ok server # [ 9.974345] postgresql-pre-start[742]: selecting dynamic shared memory implementation ... posix server # [ 9.983882] bao[512]: WARNING! dev mode is enabled! In this mode, OpenBao runs entirely in-memory server # [ 9.985025] bao[512]: and starts unsealed with a single unseal key. The root token is already server # [ 9.986069] bao[512]: authenticated to the CLI, so you can immediately begin using OpenBao. server # [ 9.987080] bao[512]: You may need to set the following environment variables: server # [ 9.987971] bao[512]: $ export BAO_ADDR='http://127.0.0.1:8200' server # [ 9.988769] bao[512]: The unseal key and root token are displayed below in case you want to server # [ 9.989799] bao[512]: seal/unseal the Vault or re-authenticate. server # [ 9.990553] bao[512]: Unseal Key: zykyMmb8k6KL5ifRpTvsNgdsprbnLF12px4tsfzV6mE= server # [ 9.991812] bao[512]: Root Token: root server # [ 9.992718] bao[512]: Development mode should NOT be used in production installations! server # [ 10.028401] dhcpcd[710]: eth0: soliciting a DHCP lease server # [ 10.191292] NET: Registered PF_PACKET protocol family server # [ 10.056506] dhcpcd[710]: eth0: offered 10.0.2.15 from 10.0.2.2 server # [ 10.058209] dhcpcd[710]: eth0: probing address 10.0.2.15/24 server # [ 10.089206] postgresql-pre-start[742]: selecting default "max_connections" ... 100 server # [ 10.187051] postgresql-pre-start[742]: selecting default "shared_buffers" ... 128MB server # [ 10.194770] systemd-vconsole-setup[686]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 10.198292] systemd[1]: Finished Virtual Console Setup. server # [ 10.682825] bao[512]: 2026-11-12T07:15:25.302Z [INFO] core: successful mount: namespace="" path=transit/ type=transit version="" server # [ 10.687156] openbao-setup-start[786]: Success! Enabled the transit secrets engine at: transit/ server # [ 10.808710] openbao-setup-start[796]: Retrieving wrapping key. server # [ 12.036868] dhcpcd[710]: eth0: soliciting an IPv6 router server # [ 12.038102] dhcpcd[710]: eth0: Router Advertisement from fe80::2 server # [ 12.038989] dhcpcd[710]: eth0: adding address fec0::5054:ff:fe12:3456/64 server # [ 12.040867] dhcpcd[710]: eth0: adding route to fec0::/64 server # [ 12.041787] dhcpcd[710]: eth0: adding default route via fe80::2 server # [ 13.310429] postgresql-pre-start[742]: selecting default time zone ... UTC server # [ 13.317442] postgresql-pre-start[742]: creating configuration files ... ok server # [ 13.414404] openbao-setup-start[796]: Wrapping source key with ephemeral key. server # [ 13.415399] openbao-setup-start[796]: Encrypting ephemeral key with wrapping key. server # [ 13.417076] openbao-setup-start[796]: Submitting wrapped key. server # [ 13.439051] openbao-setup-start[796]: Success! server # [ 13.481111] systemd[1]: Finished openbao-setup.service. server # [ 13.569462] postgresql-pre-start[742]: running bootstrap script ... ok server # [ 13.939627] postgresql-pre-start[742]: performing post-bootstrap initialization ... ok server # [ 14.073673] postgresql-pre-start[742]: syncing data to disk ... ok server # [ 14.074580] postgresql-pre-start[742]: initdb: warning: enabling "trust" authentication for local connections server # [ 14.075739] postgresql-pre-start[742]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb. server # [ 14.077579] postgresql-pre-start[742]: Success. You can now start the database server using: server # [ 14.078616] postgresql-pre-start[742]: pg_ctl -D /var/lib/postgresql/18 -l logfile start server # [ 14.150754] postgres[843]: [843] LOG: starting PostgreSQL 18.6 on x86_64-pc-linux-gnu, compiled by clang version 21.1.8, 64-bit server # [ 14.153142] postgres[843]: [843] LOG: listening on IPv6 address "::1", port 5432 server # [ 14.154287] postgres[843]: [843] LOG: listening on IPv4 address "127.0.0.1", port 5432 server # [ 14.156699] postgres[843]: [843] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" server # [ 14.169248] postgres[852]: [852] LOG: database system was shut down at 2026-11-12 07:15:28 GMT server # [ 14.173913] postgres[843]: [843] LOG: database system is ready to accept connections server # [ 14.178146] systemd[1]: Started PostgreSQL Server. server # [ 14.184440] systemd[1]: Starting PostgreSQL Setup Scripts... server # [ 14.307331] postgresql-setup-start[863]: CREATE DATABASE server # [ 14.336287] postgresql-setup-start[868]: CREATE ROLE server # [ 14.347518] postgresql-setup-start[870]: ALTER DATABASE server # [ 14.351857] systemd[1]: Finished PostgreSQL Setup Scripts. server # [ 14.353773] systemd[1]: Reached target PostgreSQL. server # [ 15.305388] dhcpcd[710]: eth0: leased 10.0.2.15 for 86400 seconds server # [ 15.307963] dhcpcd[710]: eth0: adding route to 10.0.2.0/24 server # [ 15.310816] dhcpcd[710]: eth0: adding default route via 10.0.2.2 server # [ 15.391434] systemd[1]: Started DHCP Client. server # [ 22.513762] rustfs-setup-start[1008]: mb s3://niks3-test server # [ 22.519698] systemd[1]: Finished Setup RustFS bucket. server # [ 22.526453] systemd[1]: Starting niks3 server... server # [ 22.721218] niks3-server[1018]: 2026/11/12 07:15:37 INFO Configured external signer program=/nix/store/dm3aql8b11ipqnvzw33pxx5fn91i65bs-niks3-openbao-signer/bin/niks3-openbao-signer server # [ 22.782985] niks3-server[1018]: 2026/11/12 07:15:37 INFO Installed lifecycle rule aborting incomplete NAR uploads bucket=niks3-test days=2 server # [ 22.787335] niks3-server[1018]: 2026/11/12 07:15:37 INFO Read proxy enabled — serving cache objects from S3 server # [ 22.788866] niks3-server[1018]: 2026/11/12 07:15:37 INFO Using socket-activated listener address=0.0.0.0:5751 server # [ 22.792110] niks3-server[1018]: 2026/11/12 07:15:37 INFO systemd watchdog enabled interval=15s server # [ 22.793277] niks3-server[1018]: 2026/11/12 07:15:37 INFO Starting HTTP server address=0.0.0.0:5751 server # [ 22.794444] systemd[1]: Started niks3 server. server # [ 22.795137] systemd[1]: Reached target Multi-User System. server # [ 22.797159] systemd[1]: Startup finished in 841ms (kernel) + 4.482s (initrd) + 17.473s (userspace) = 22.797s. [23.72s] server: (finished: waiting for unit niks3.service, in 23.72 seconds) [23.72s] server: waiting for TCP port 5751 on localhost server # Connection to localhost (127.0.0.1) 5751 port [tcp/*] succeeded! [23.75s] server: (finished: waiting for TCP port 5751 on localhost, in 0.03 seconds) [23.75s] server: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/auth-token [23.76s] server: (finished: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/auth-token, in 0.01 seconds) [23.76s] subtest: narinfos signed through OpenBao verify against the public key [23.76s] server: must succeed: nix-build -E 'derivation { name="signer-1"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-1 > $out"]; }' --no-out-link server # this derivation will be built: server # /nix/store/xsaww49bj3jyzrjxl784g7nq5sci6v3s-signer-1.drv server # building '/nix/store/xsaww49bj3jyzrjxl784g7nq5sci6v3s-signer-1.drv'... [23.89s] server: (finished: must succeed: nix-build -E 'derivation { name="signer-1"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-1 > $out"]; }' --no-out-link, in 0.13 seconds) [23.89s] server: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1 server # [ 23.118308] niks3-server[1018]: 2026/11/12 07:15:37 INFO Received push request method=POST path=/api/pushes server # time=2026-11-12T07:15:37.744Z level=INFO msg="Uploading 1 paths to localhost (0 already cached)" server # time=2026-11-12T07:15:37.745Z level=INFO msg="Uploading ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1 (128B)" server # [ 23.161989] niks3-server[1018]: 2026/11/12 07:15:37 INFO Registered completed upload object_key=ccr6560gzlizgp89dw67dhvzrbdwngfs.ls server # [ 23.166672] niks3-server[1018]: 2026/11/12 07:15:37 INFO Received sign narinfos request method=POST path=/api/pushes/1/sign server # [ 23.194643] niks3-server[1018]: 2026/11/12 07:15:37 INFO Registered completed upload object_key=nar/1xbdd0jsa3f9d9xz2wfpcjbcrx5dpyy490mg6cnrlkqswmwsm6j0.nar.zst server # [ 23.196687] niks3-server[1018]: 2026/11/12 07:15:37 INFO Registered completed upload object_key=log/xsaww49bj3jyzrjxl784g7nq5sci6v3s-signer-1.drv server # [ 23.219258] niks3-server[1018]: 2026/11/12 07:15:37 INFO Signed narinfos id=1 count=1 server # time=2026-11-12T07:15:37.840Z level=INFO msg="Uploading 1 narinfos" server # [ 23.236758] niks3-server[1018]: 2026/11/12 07:15:37 INFO Received complete push request method=POST path=/api/pushes/1/complete server # [ 23.243731] niks3-server[1018]: 2026/11/12 07:15:37 INFO Registered completed upload object_key=ccr6560gzlizgp89dw67dhvzrbdwngfs.narinfo server # time=2026-11-12T07:15:37.867Z level=INFO msg="Upload complete. (175ms)" server # [ 23.249559] niks3-server[1018]: 2026/11/12 07:15:37 INFO Completed push id=1 objects=4 duration=10.90362ms [24.14s] server: (finished: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1, in 0.25 seconds) [24.14s] server: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-1 /nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1 server # copying 1 paths... server # copying path '/nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1' from 'http://localhost:5751'... [24.24s] server: (finished: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-1 /nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1, in 0.10 seconds) [24.24s] server: must succeed: nix --store /tmp/store-1 store cat /nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1 | grep -F signer- [24.29s] server: (finished: must succeed: nix --store /tmp/store-1 store cat /nix/store/ccr6560gzlizgp89dw67dhvzrbdwngfs-signer-1 | grep -F signer-, in 0.05 seconds) [24.29s] (finished: subtest: narinfos signed through OpenBao verify against the public key, in 0.53 seconds) [24.29s] subtest: the signing process is reused across pushes [24.29s] server: must succeed: pgrep -x niks3-openbao-s | head -n1 [24.31s] server: (finished: must succeed: pgrep -x niks3-openbao-s | head -n1, in 0.03 seconds) [24.31s] server: must succeed: nix-build -E 'derivation { name="signer-2"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-2 > $out"]; }' --no-out-link server # this derivation will be built: server # /nix/store/5asrlih8nqb505aw3x6396fzqbjm5w9j-signer-2.drv server # building '/nix/store/5asrlih8nqb505aw3x6396fzqbjm5w9j-signer-2.drv'... [24.43s] server: (finished: must succeed: nix-build -E 'derivation { name="signer-2"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-2 > $out"]; }' --no-out-link, in 0.12 seconds) [24.43s] server: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2 server # [ 23.635331] niks3-server[1018]: 2026/11/12 07:15:38 INFO Received push request method=POST path=/api/pushes server # time=2026-11-12T07:15:38.260Z level=INFO msg="Uploading 1 paths to localhost (0 already cached)" server # time=2026-11-12T07:15:38.262Z level=INFO msg="Uploading g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2 (128B)" server # [ 23.675732] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=g4cb183m3i1illkc1c0r2i7b6c1wk4sf.ls server # [ 23.678681] niks3-server[1018]: 2026/11/12 07:15:38 INFO Received sign narinfos request method=POST path=/api/pushes/2/sign server # [ 23.685606] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=log/5asrlih8nqb505aw3x6396fzqbjm5w9j-signer-2.drv server # time=2026-11-12T07:15:38.307Z level=INFO msg="Uploading 1 narinfos" server # [ 23.688796] niks3-server[1018]: 2026/11/12 07:15:38 INFO Signed narinfos id=2 count=1 server # [ 23.690315] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=nar/0nwavznx6l2iygh4lpjn8msr9hyp614fcfihlbm95zgkr76jikcj.nar.zst server # [ 23.706257] niks3-server[1018]: 2026/11/12 07:15:38 INFO Received complete push request method=POST path=/api/pushes/2/complete server # [ 23.711285] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=g4cb183m3i1illkc1c0r2i7b6c1wk4sf.narinfo server # time=2026-11-12T07:15:38.334Z level=INFO msg="Upload complete. (120ms)" server # [ 23.715580] niks3-server[1018]: 2026/11/12 07:15:38 INFO Completed push id=2 objects=4 duration=8.528179ms [24.61s] server: (finished: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2, in 0.18 seconds) [24.61s] server: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-2 /nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2 server # copying 1 paths... server # copying path '/nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2' from 'http://localhost:5751'... [24.69s] server: (finished: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-2 /nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2, in 0.08 seconds) [24.69s] server: must succeed: nix --store /tmp/store-2 store cat /nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2 | grep -F signer- [24.74s] server: (finished: must succeed: nix --store /tmp/store-2 store cat /nix/store/g4cb183m3i1illkc1c0r2i7b6c1wk4sf-signer-2 | grep -F signer-, in 0.05 seconds) [24.74s] server: must succeed: pgrep -x niks3-openbao-s | head -n1 [24.76s] server: (finished: must succeed: pgrep -x niks3-openbao-s | head -n1, in 0.02 seconds) [24.76s] (finished: subtest: the signing process is reused across pushes, in 0.47 seconds) [24.76s] subtest: a killed signing process is restarted [24.76s] server: must succeed: pkill -KILL -x niks3-openbao-s [24.78s] server: (finished: must succeed: pkill -KILL -x niks3-openbao-s, in 0.02 seconds) [24.78s] server: must succeed: nix-build -E 'derivation { name="signer-3"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-3 > $out"]; }' --no-out-link server # this derivation will be built: server # /nix/store/690vc1n2hpjzyg5k7r8ak9j29x35yjav-signer-3.drv server # building '/nix/store/690vc1n2hpjzyg5k7r8ak9j29x35yjav-signer-3.drv'... [24.89s] server: (finished: must succeed: nix-build -E 'derivation { name="signer-3"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-3 > $out"]; }' --no-out-link, in 0.11 seconds) [24.89s] server: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3 server # [ 24.092324] niks3-server[1018]: 2026/11/12 07:15:38 INFO Received push request method=POST path=/api/pushes server # time=2026-11-12T07:15:38.717Z level=INFO msg="Uploading 1 paths to localhost (0 already cached)" server # time=2026-11-12T07:15:38.718Z level=INFO msg="Uploading j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3 (128B)" server # [ 24.136644] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=log/690vc1n2hpjzyg5k7r8ak9j29x35yjav-signer-3.drv server # [ 24.143166] niks3-server[1018]: 2026/11/12 07:15:38 INFO Received sign narinfos request method=POST path=/api/pushes/3/sign server # [ 24.144851] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=j82pa3l46yhmddg860sc999r8x7fhmcc.ls server # [ 24.150142] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=nar/0a5xm19dinsl6r6mgmzvlxv91jdb1hr34kxlyic4f5w7c5db29z4.nar.zst server # time=2026-11-12T07:15:38.778Z level=INFO msg="Uploading 1 narinfos" server # [ 24.160632] niks3-server[1018]: 2026/11/12 07:15:38 INFO Signed narinfos id=3 count=1 server # [ 24.171700] niks3-server[1018]: 2026/11/12 07:15:38 INFO Received complete push request method=POST path=/api/pushes/3/complete server # time=2026-11-12T07:15:38.796Z level=INFO msg="Upload complete. (125ms)" server # [ 24.177755] niks3-server[1018]: 2026/11/12 07:15:38 INFO Completed push id=3 objects=4 duration=4.942807ms server # [ 24.179772] niks3-server[1018]: 2026/11/12 07:15:38 INFO Registered completed upload object_key=j82pa3l46yhmddg860sc999r8x7fhmcc.narinfo [25.07s] server: (finished: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3, in 0.18 seconds) [25.07s] server: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-3 /nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3 server # copying 1 paths... server # copying path '/nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3' from 'http://localhost:5751'... [25.15s] server: (finished: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-3 /nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3, in 0.08 seconds) [25.15s] server: must succeed: nix --store /tmp/store-3 store cat /nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3 | grep -F signer- [25.20s] server: (finished: must succeed: nix --store /tmp/store-3 store cat /nix/store/j82pa3l46yhmddg860sc999r8x7fhmcc-signer-3 | grep -F signer-, in 0.05 seconds) [25.20s] (finished: subtest: a killed signing process is restarted, in 0.44 seconds) [25.20s] subtest: OpenBao errors fail the push without crashing the server [25.20s] server: must succeed: systemctl stop openbao-dev.service server # [ 24.327563] bao[512]: ==> OpenBao shutdown triggered server # [ 24.328783] bao[512]: 2026-11-12T07:15:38.946Z [INFO] core: marked as sealed server # [ 24.331058] bao[512]: 2026-11-12T07:15:38.946Z [INFO] core: pre-seal teardown starting server # [ 24.332315] systemd[1]: Stopping openbao-dev.service... server # [ 24.335080] bao[512]: 2026-11-12T07:15:38.954Z [INFO] rollback: stopping rollback manager server # [ 24.338159] bao[512]: 2026-11-12T07:15:38.957Z [INFO] core: pre-seal teardown complete server # [ 24.339406] bao[512]: 2026-11-12T07:15:38.958Z [INFO] core: stopping cluster listeners server # [ 24.340442] bao[512]: 2026-11-12T07:15:38.959Z [INFO] core.cluster-listener: forwarding rpc listeners stopped server # [ 24.768736] bao[512]: 2026-11-12T07:15:39.388Z [INFO] core.cluster-listener: rpc listeners successfully shut down server # [ 24.774114] bao[512]: 2026-11-12T07:15:39.388Z [INFO] core: cluster listeners successfully shut down server # [ 24.776962] bao[512]: 2026-11-12T07:15:39.392Z [INFO] core: vault is sealed server # [ 24.789455] systemd[1]: openbao-dev.service: Deactivated successfully. server # [ 24.792979] systemd[1]: Stopped openbao-dev.service. server # [ 24.797166] systemd[1]: openbao-dev.service: Consumed 2.517s CPU time over 16.647s wall clock time, 75.1M memory peak, 4.4K incoming IP traffic, 4.9K outgoing IP traffic. [25.70s] server: (finished: must succeed: systemctl stop openbao-dev.service, in 0.50 seconds) [25.70s] server: must succeed: nix-build -E 'derivation { name="signer-4"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-4 > $out"]; }' --no-out-link server # this derivation will be built: server # /nix/store/6z5x25a307y69hc8y846il1a2yn7c6b9-signer-4.drv server # building '/nix/store/6z5x25a307y69hc8y846il1a2yn7c6b9-signer-4.drv'... [25.85s] server: (finished: must succeed: nix-build -E 'derivation { name="signer-4"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-4 > $out"]; }' --no-out-link, in 0.15 seconds) [25.85s] server: must fail: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/h9x5fql7nfamn3mpz7b7mpp1mbini4n9-signer-4 server # [ 25.070877] niks3-server[1018]: 2026/11/12 07:15:39 INFO Received push request method=POST path=/api/pushes server # time=2026-11-12T07:15:39.698Z level=INFO msg="Uploading 1 paths to localhost (0 already cached)" server # time=2026-11-12T07:15:39.699Z level=INFO msg="Uploading h9x5fql7nfamn3mpz7b7mpp1mbini4n9-signer-4 (128B)" server # [ 25.121338] niks3-server[1018]: 2026/11/12 07:15:39 INFO Registered completed upload object_key=log/6z5x25a307y69hc8y846il1a2yn7c6b9-signer-4.drv server # [ 25.126556] niks3-server[1018]: 2026/11/12 07:15:39 INFO Received sign narinfos request method=POST path=/api/pushes/4/sign server # [ 25.129658] niks3-server[1018]: 2026/11/12 07:15:39 INFO Registered completed upload object_key=h9x5fql7nfamn3mpz7b7mpp1mbini4n9.ls server # time=2026-11-12T07:15:39.751Z level=WARN msg="Request returned retryable status, retrying" attempt=1 backoff=100ms status=500 url=http://localhost:5751/api/pushes/4/sign server # [ 25.133565] niks3-server[1018]: 2026/11/12 07:15:39 ERROR Failed to sign narinfos signer=niks3-test-1 error="signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory" server # [ 25.139847] niks3-server[1018]: 2026/11/12 07:15:39 INFO Registered completed upload object_key=nar/08bvxj5dmksfdkqa4pjy110ni52l4pkvb9a02p3qa256f0idj24s.nar.zst server # [ 25.237911] niks3-server[1018]: 2026/11/12 07:15:39 INFO Received sign narinfos request method=POST path=/api/pushes/4/sign server # time=2026-11-12T07:15:39.860Z level=WARN msg="Request returned retryable status, retrying" attempt=2 backoff=219.913699ms status=500 url=http://localhost:5751/api/pushes/4/sign server # [ 25.242798] niks3-server[1018]: 2026/11/12 07:15:39 ERROR Failed to sign narinfos signer=niks3-test-1 error="signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory" server # [ 25.464241] niks3-server[1018]: 2026/11/12 07:15:40 INFO Received sign narinfos request method=POST path=/api/pushes/4/sign server # [ 25.467075] niks3-server[1018]: 2026/11/12 07:15:40 ERROR Failed to sign narinfos signer=niks3-test-1 error="signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory" server # time=2026-11-12T07:15:40.089Z level=WARN msg="Request returned retryable status, retrying" attempt=3 backoff=379.782208ms status=500 url=http://localhost:5751/api/pushes/4/sign server # [ 25.853110] niks3-server[1018]: 2026/11/12 07:15:40 INFO Received sign narinfos request method=POST path=/api/pushes/4/sign server # time=2026-11-12T07:15:40.475Z level=WARN msg="Request returned retryable status, retrying" attempt=4 backoff=865.405627ms status=500 url=http://localhost:5751/api/pushes/4/sign server # [ 25.857671] niks3-server[1018]: 2026/11/12 07:15:40 ERROR Failed to sign narinfos signer=niks3-test-1 error="signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory" server # [ 26.724664] niks3-server[1018]: 2026/11/12 07:15:41 INFO Received sign narinfos request method=POST path=/api/pushes/4/sign server # [ 26.727429] niks3-server[1018]: 2026/11/12 07:15:41 ERROR Failed to sign narinfos signer=niks3-test-1 error="signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory" server # time=2026-11-12T07:15:41.350Z level=WARN msg="Request returned retryable status, retrying" attempt=5 backoff=1.746473414s status=500 url=http://localhost:5751/api/pushes/4/sign server # [ 28.480592] niks3-server[1018]: 2026/11/12 07:15:43 INFO Received sign narinfos request method=POST path=/api/pushes/4/sign server # time=2026-11-12T07:15:43.103Z level=ERROR msg="Fatal error" error="pushing paths: signing and uploading narinfos: signing narinfos for closure 4: server returned 500: failed to sign narinfos: signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory\n" server # [ 28.487051] niks3-server[1018]: 2026/11/12 07:15:43 ERROR Failed to sign narinfos signer=niks3-test-1 error="signing program: narinfo \"h9x5fql7nfamn3mpz7b7mpp1mbini4n9.narinfo\": reading token: open /run/openbao-signer/token: no such file or directory" [29.38s] server: (finished: must fail: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/h9x5fql7nfamn3mpz7b7mpp1mbini4n9-signer-4, in 3.54 seconds) [29.38s] server: must succeed: systemctl restart openbao-setup.service server # [ 28.514807] niks3-server[1018]: 2026/11/12 07:15:43 INFO Shutdown signal received, draining in-flight requests timeout=10s server # [ 28.516393] systemd[1]: Stopping niks3 server... server # [ 28.531724] systemd[1]: niks3.service: Deactivated successfully. server # [ 28.534167] systemd[1]: Stopped niks3 server. server # [ 28.534881] systemd[1]: niks3.service: Consumed 158ms CPU time over 6.006s wall clock time, 29.7M memory peak, 20K incoming IP traffic, 25.9K outgoing IP traffic. server # [ 28.540427] systemd[1]: openbao-setup.service: Deactivated successfully. server # [ 28.542103] systemd[1]: Stopped openbao-setup.service. server # [ 28.542855] systemd[1]: openbao-setup.service: Consumed 440ms CPU time over 20.387s wall clock time, 41.8M memory peak, 3K incoming IP traffic, 2.8K outgoing IP traffic. server # [ 28.544680] systemd[1]: Stopping openbao-setup.service... server # [ 28.547511] systemd[1]: Started openbao-dev.service. server # [ 28.552528] systemd[1]: Starting openbao-setup.service... server # [ 28.787645] bao[1226]: 2026-11-12T07:15:43.406Z [INFO] proxy environment: http_proxy="" https_proxy="" no_proxy="" server # [ 28.790215] bao[1226]: 2026-11-12T07:15:43.409Z [WARN] no `api_addr` value specified in config or in BAO_API_ADDR; falling back to detection if possible, but this value should be manually set server # [ 28.793105] bao[1226]: 2026-11-12T07:15:43.409Z [INFO] core: Initializing version history cache for core server # [ 28.795159] bao[1226]: ==> OpenBao server configuration: server # [ 28.796168] bao[1226]: Api Address: http://127.0.0.1:8200 server # [ 28.797068] bao[1226]: Cgo: enabled server # [ 28.797820] bao[1226]: Cluster Address: https://127.0.0.1:8201 server # [ 28.798719] bao[1226]: Environment Variables: HOME, INVOCATION_ID, IO_PRESSURE_WATCH, IO_PRESSURE_WRITE, JOURNAL_STREAM, LANG, LOCALE_ARCHIVE, LOGNAME, MEMORY_PRESSURE_WATCH, MEMORY_PRESSURE_WRITE, PATH, RUNTIME_DIRECTORY, STATE_DIRECTORY, SYSTEMD_EXEC_PID, TZDIR, USER server # [ 28.801509] bao[1226]: Go Version: go1.27.3 server # [ 28.802866] bao[1226]: Listener 1: tcp (addr: "127.0.0.1:8200", cluster address: "127.0.0.1:8201", max_request_duration: "1m30s", max_request_json_memory: "34078720", max_request_json_strings: "1000", max_request_size: "33554432", tls: "disabled") server # [ 28.805803] bao[1226]: Log Level: server # [ 28.807085] bao[1226]: Recovery Mode: false server # [ 28.807800] bao[1226]: Storage: inmem server # [ 28.808540] bao[1226]: Version: OpenBao v2.7.2, committed 1970-01-01T00:00:00Z server # [ 28.809863] bao[1226]: Version Sha: refs/tags/v2.7.2 server # [ 28.812142] bao[1226]: 2026-11-12T07:15:43.422Z [INFO] core: security barrier not initialized server # [ 28.813293] bao[1226]: 2026-11-12T07:15:43.430Z [INFO] core: security barrier initialized: shares=1 threshold=1 server # [ 28.814627] bao[1226]: 2026-11-12T07:15:43.431Z [INFO] core: post-unseal setup starting server # [ 28.829111] bao[1226]: 2026-11-12T07:15:43.448Z [INFO] core: loaded wrapping token key server # [ 28.832129] bao[1226]: 2026-11-12T07:15:43.450Z [INFO] core: successfully setup plugin catalog: plugin-directory="" server # [ 28.833520] bao[1226]: 2026-11-12T07:15:43.451Z [INFO] core: reading transactional mount table server # [ 28.834663] bao[1226]: 2026-11-12T07:15:43.451Z [INFO] core: no mounts in transactional mount table; adding default mount table server # [ 28.838505] bao[1226]: 2026-11-12T07:15:43.458Z [INFO] core: successfully mounted: type=cubbyhole version="v2.7.2+builtin.bao" path=cubbyhole/ namespace="ID: root. Path: " server # [ 28.840982] bao[1226]: 2026-11-12T07:15:43.460Z [INFO] core: successfully mounted: type=system version="v2.7.2+builtin.bao" path=sys/ namespace="ID: root. Path: " server # [ 28.843274] bao[1226]: 2026-11-12T07:15:43.463Z [INFO] core: successfully mounted: type=identity version="v2.7.2+builtin.bao" path=identity/ namespace="ID: root. Path: " server # [ 28.847540] bao[1226]: 2026-11-12T07:15:43.467Z [INFO] core: reading transactional auth mount table server # [ 28.848987] bao[1226]: 2026-11-12T07:15:43.468Z [INFO] core: no auth mounts in transactional auth mount table; adding default auth mount table server # [ 28.854063] bao[1226]: 2026-11-12T07:15:43.473Z [INFO] core: successfully mounted: type=token version="v2.7.2+builtin.bao" path=token/ namespace="ID: root. Path: " server # [ 28.856094] bao[1226]: 2026-11-12T07:15:43.475Z [INFO] rollback: Starting the rollback manager with 256 workers server # [ 28.858987] bao[1226]: 2026-11-12T07:15:43.478Z [INFO] core: restoring leases server # [ 28.864662] bao[1226]: 2026-11-12T07:15:43.484Z [INFO] expiration: lease restore complete server # [ 28.867530] bao[1226]: 2026-11-12T07:15:43.486Z [INFO] rollback: starting rollback manager server # [ 28.868811] bao[1226]: 2026-11-12T07:15:43.488Z [INFO] core: entities restored server # [ 28.869923] bao[1226]: 2026-11-12T07:15:43.489Z [INFO] core: groups restored server # [ 28.871581] bao[1226]: 2026-11-12T07:15:43.491Z [INFO] core: Recorded vault version: vault version=2.7.2 upgrade time="2026-11-12 07:15:43.491056402 +0000 UTC" commit date=1970-01-01T00:00:00Z server # [ 28.875086] bao[1226]: 2026-11-12T07:15:43.494Z [INFO] core: post-unseal setup complete server # [ 28.877612] bao[1226]: 2026-11-12T07:15:43.497Z [INFO] core: root token generated server # [ 28.878708] bao[1226]: 2026-11-12T07:15:43.498Z [INFO] core: pre-seal teardown starting server # [ 28.882065] bao[1226]: 2026-11-12T07:15:43.500Z [INFO] rollback: stopping rollback manager server # [ 28.883682] bao[1226]: 2026-11-12T07:15:43.503Z [INFO] core: pre-seal teardown complete server # [ 28.885389] bao[1226]: 2026-11-12T07:15:43.505Z [INFO] core.cluster-listener.tcp: starting listener: listener_address=127.0.0.1:8201 server # [ 28.887058] bao[1226]: 2026-11-12T07:15:43.506Z [INFO] core.cluster-listener: serving cluster requests: cluster_listen_address=127.0.0.1:8201 server # [ 28.888867] bao[1226]: 2026-11-12T07:15:43.508Z [INFO] core: post-unseal setup starting server # [ 28.890259] bao[1226]: 2026-11-12T07:15:43.510Z [INFO] core: loaded wrapping token key server # [ 28.893062] bao[1226]: 2026-11-12T07:15:43.511Z [INFO] core: successfully setup plugin catalog: plugin-directory="" server # [ 28.894361] bao[1226]: 2026-11-12T07:15:43.511Z [INFO] core: reading transactional mount table server # [ 28.895469] bao[1226]: 2026-11-12T07:15:43.512Z [INFO] core: successfully mounted: type=identity version="v2.7.2+builtin.bao" path=identity/ namespace="ID: root. Path: " server # [ 28.897810] bao[1226]: 2026-11-12T07:15:43.517Z [INFO] core: successfully mounted: type=system version="v2.7.2+builtin.bao" path=sys/ namespace="ID: root. Path: " server # [ 28.899675] bao[1226]: 2026-11-12T07:15:43.519Z [INFO] core: successfully mounted: type=cubbyhole version="v2.7.2+builtin.bao" path=cubbyhole/ namespace="ID: root. Path: " server # [ 28.902800] bao[1226]: 2026-11-12T07:15:43.522Z [INFO] core: reading transactional auth mount table server # [ 28.904548] bao[1226]: 2026-11-12T07:15:43.524Z [INFO] core: successfully mounted: type=token version="v2.7.2+builtin.bao" path=token/ namespace="ID: root. Path: " server # [ 28.906709] bao[1226]: 2026-11-12T07:15:43.526Z [INFO] rollback: Starting the rollback manager with 256 workers server # [ 28.908823] bao[1226]: 2026-11-12T07:15:43.528Z [INFO] core: restoring leases server # [ 28.911635] bao[1226]: 2026-11-12T07:15:43.531Z [INFO] expiration: lease restore complete server # [ 28.913932] bao[1226]: 2026-11-12T07:15:43.533Z [INFO] rollback: starting rollback manager server # [ 28.915636] bao[1226]: 2026-11-12T07:15:43.535Z [INFO] core: entities restored server # [ 28.916713] bao[1226]: 2026-11-12T07:15:43.536Z [INFO] core: groups restored server # [ 28.918627] bao[1226]: 2026-11-12T07:15:43.538Z [INFO] core: post-unseal setup complete server # [ 28.919833] bao[1226]: 2026-11-12T07:15:43.539Z [INFO] core: vault is unsealed server # [ 28.926825] bao[1226]: 2026-11-12T07:15:43.546Z [INFO] expiration: revoked lease: lease_id=auth/token/root/h598b28bf6593e5bd751a2ab69d61e661dad76a07505b1172f6c14f42d9048e78 server # [ 28.932867] bao[1226]: 2026-11-12T07:15:43.552Z [INFO] core: successful mount: namespace="" path=secret/ type=kv version="" server # [ 28.934193] bao[1226]: 2026-11-12T07:15:43.552Z [INFO] beginning post-unseal configuration server # [ 28.935698] bao[1226]: ==> OpenBao server started! server # [ 28.943235] bao[1226]: 2026-11-12T07:15:43.562Z [INFO] secrets.kv.kv_a58a1e71: collecting keys to upgrade server # [ 28.944877] bao[1226]: 2026-11-12T07:15:43.564Z [INFO] secrets.kv.kv_a58a1e71: done collecting keys: num_keys=1 server # [ 28.946270] bao[1226]: 2026-11-12T07:15:43.566Z [INFO] secrets.kv.kv_a58a1e71: upgrading keys finished server # [ 29.049042] bao[1226]: WARNING! dev mode is enabled! In this mode, OpenBao runs entirely in-memory server # [ 29.050366] bao[1226]: and starts unsealed with a single unseal key. The root token is already server # [ 29.051478] bao[1226]: authenticated to the CLI, so you can immediately begin using OpenBao. server # [ 29.052558] bao[1226]: You may need to set the following environment variables: server # [ 29.053511] bao[1226]: $ export BAO_ADDR='http://127.0.0.1:8200' server # [ 29.054467] bao[1226]: The unseal key and root token are displayed below in case you want to server # [ 29.056315] bao[1226]: seal/unseal the Vault or re-authenticate. server # [ 29.057378] bao[1226]: Unseal Key: D4S5KPJ1wC5KChwexaTxaErUGHfMA5qzpvJrdWaR5Ks= server # [ 29.058421] bao[1226]: Root Token: root server # [ 29.058977] bao[1226]: Development mode should NOT be used in production installations! server # [ 30.073440] bao[1226]: 2026-11-12T07:15:44.692Z [INFO] core: successful mount: namespace="" path=transit/ type=transit version="" server # [ 30.077409] openbao-setup-start[1249]: Success! Enabled the transit secrets engine at: transit/ server # [ 30.178694] openbao-setup-start[1258]: Retrieving wrapping key. server # [ 31.015708] openbao-setup-start[1258]: Wrapping source key with ephemeral key. server # [ 31.016854] openbao-setup-start[1258]: Encrypting ephemeral key with wrapping key. server # [ 31.017764] openbao-setup-start[1258]: Submitting wrapped key. server # [ 31.029080] openbao-setup-start[1258]: Success! server # [ 31.040524] systemd[1]: Finished openbao-setup.service. [31.94s] server: (finished: must succeed: systemctl restart openbao-setup.service, in 2.56 seconds) server # [ 31.048336] systemd[1]: Starting niks3 server... [31.94s] server: must succeed: nix-build -E 'derivation { name="signer-5"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-5 > $out"]; }' --no-out-link server # [ 31.148359] niks3-server[1266]: 2026/11/12 07:15:45 INFO Configured external signer program=/nix/store/dm3aql8b11ipqnvzw33pxx5fn91i65bs-niks3-openbao-signer/bin/niks3-openbao-signer server # [ 31.162889] niks3-server[1266]: 2026/11/12 07:15:45 INFO Read proxy enabled — serving cache objects from S3 server # [ 31.164419] niks3-server[1266]: 2026/11/12 07:15:45 INFO Using socket-activated listener address=0.0.0.0:5751 server # [ 31.166622] niks3-server[1266]: 2026/11/12 07:15:45 INFO systemd watchdog enabled interval=15s server # [ 31.168124] niks3-server[1266]: 2026/11/12 07:15:45 INFO Starting HTTP server address=0.0.0.0:5751 server # [ 31.169828] systemd[1]: Started niks3 server. server # this derivation will be built: server # /nix/store/bqsh510vk6kx4ynb4vifzbffdv3pym0x-signer-5.drv server # building '/nix/store/bqsh510vk6kx4ynb4vifzbffdv3pym0x-signer-5.drv'... [32.14s] server: (finished: must succeed: nix-build -E 'derivation { name="signer-5"; system=builtins.currentSystem; builder="/bin/sh"; args=["-c" "echo signer-5 > $out"]; }' --no-out-link, in 0.20 seconds) [32.14s] server: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5 server # [ 31.361694] niks3-server[1266]: 2026/11/12 07:15:45 INFO Received push request method=POST path=/api/pushes server # time=2026-11-12T07:15:45.987Z level=INFO msg="Uploading 1 paths to localhost (0 already cached)" server # time=2026-11-12T07:15:45.988Z level=INFO msg="Uploading 2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5 (128B)" server # [ 31.416219] niks3-server[1266]: 2026/11/12 07:15:46 INFO Registered completed upload object_key=2ifz3szqnr8jjys2nvr5kxiw20gzifx0.ls server # [ 31.419220] niks3-server[1266]: 2026/11/12 07:15:46 INFO Received sign narinfos request method=POST path=/api/pushes/5/sign server # [ 31.432177] niks3-server[1266]: 2026/11/12 07:15:46 INFO Registered completed upload object_key=nar/1rrjdxihgavl3xr6jzkh49lrd92dlyrdgs4inygpqssjvgcrjh9x.nar.zst server # [ 31.435660] niks3-server[1266]: 2026/11/12 07:15:46 INFO Registered completed upload object_key=log/bqsh510vk6kx4ynb4vifzbffdv3pym0x-signer-5.drv server # [ 31.443886] niks3-server[1266]: 2026/11/12 07:15:46 INFO Signed narinfos id=5 count=1 server # time=2026-11-12T07:15:46.065Z level=INFO msg="Uploading 1 narinfos" server # [ 31.460027] niks3-server[1266]: 2026/11/12 07:15:46 INFO Received complete push request method=POST path=/api/pushes/5/complete server # time=2026-11-12T07:15:46.087Z level=INFO msg="Upload complete. (157ms)" server # [ 31.468907] niks3-server[1266]: 2026/11/12 07:15:46 INFO Completed push id=5 objects=4 duration=7.932572ms server # [ 31.476057] niks3-server[1266]: 2026/11/12 07:15:46 INFO Registered completed upload object_key=2ifz3szqnr8jjys2nvr5kxiw20gzifx0.narinfo [32.37s] server: (finished: must succeed: NIKS3_SERVER_URL=http://localhost:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/auth-token /nix/store/idl32vhmscyx483cr739ys0gabh0wpbf-niks3-1.17.0/bin/niks3 push /nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5, in 0.23 seconds) [32.37s] server: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-5 /nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5 server # copying 1 paths... server # copying path '/nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5' from 'http://localhost:5751'... [32.47s] server: (finished: must succeed: nix copy --from http://localhost:5751 --to /tmp/store-5 /nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5, in 0.10 seconds) [32.47s] server: must succeed: nix --store /tmp/store-5 store cat /nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5 | grep -F signer- [32.55s] server: (finished: must succeed: nix --store /tmp/store-5 store cat /nix/store/2ifz3szqnr8jjys2nvr5kxiw20gzifx0-signer-5 | grep -F signer-, in 0.08 seconds) [32.55s] (finished: subtest: OpenBao errors fail the push without crashing the server, in 7.35 seconds) [32.55s] (finished: run the VM test script, in 32.54 seconds) [32.59s] test script finished in 32.58s [32.59s] cleanup [32.59s] kill QemuMachine (pid 45) server # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14) server # [2026-11-12T07:15:47Z INFO virtiofsd] Client disconnected, shutting down server # [2026-11-12T07:15:47Z INFO virtiofsd] Client disconnected, shutting down server # [2026-11-12T07:15:47Z INFO virtiofsd] Client disconnected, shutting down [32.86s] (finished: cleanup, in 0.28 seconds) additionally exposed symbols: server, vlan1, 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