tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) start vhost-device-vsock (finished: start vhost-device-vsock, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script start all VMs hub: starting vm worker: starting vm hub: QEMU running (pid 54) hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.WGqpSxcjXu', fmt=raw size=4294967296 hub # mke2fs 1.47.4 (6-Mar-2025) hub # Discarding device blocks: 0/1048576 done hub # Creating filesystem with 1048576 4k blocks and 262144 inodes hub # Filesystem UUID: cb554442-6aa9-49e2-9f0f-f1e9a0878e18 hub # Superblock backups stored on blocks: hub # 32768, 98304, 163840, 229376, 294912, 819200, 884736 hub # hub # Allocating group tables: 0/32 done hub # Writing inode tables: 0/32 done hub # Creating journal (16384 blocks): done hub # Writing superblocks and filesystem accounting information: 0/32 done hub # hub # Virtualisation disk image created. hub # Starting virtiofs daemons... hub # [2026-10-18T16:58:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-10-18T16:58:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-10-18T16:58:26Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-10-18T16:58:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-10-18T16:58:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-10-18T16:58:26Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-10-18T16:58:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-10-18T16:58:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-10-18T16:58:26Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-10-18T16:58:26Z INFO virtiofsd] Client connected, servicing requests hub # [2026-10-18T16:58:26Z INFO virtiofsd] Client connected, servicing requests hub # [2026-10-18T16:58:26Z INFO virtiofsd] Client connected, servicing requests hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC660+7EF2C660 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 7EFCC660 7EF2C660 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:05.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 hub # [ 0.000000] Command line: loglevel=4 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/iinrbrwcm8jzlhkn4lcl9279rc8cci4x-nixos-system-hub-test/init regInfo=/nix/.ro-store/cp0ahs3wn2ihxblc2kyd23wddj884nk7-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.000000] BIOS-provided physical RAM map: hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000017fffffff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved hub # [ 0.000000] NX (Execute Disable) protection: active hub # [ 0.000000] APIC: Static calls initialized hub # [ 0.000000] SMBIOS 2.8 present. hub # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 hub # [ 0.000000] DMI: Memory slots populated: 1/1 hub # [ 0.000000] Hypervisor detected: KVM hub # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000000] kvm-clock: using sched offset of 512824575 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000005] tsc: Detected 2400.008 MHz processor hub # [ 0.000757] last_pfn = 0x180000 max_arch_pfn = 0x10000000000 hub # [ 0.000790] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000792] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.000830] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 hub # [ 0.002663] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.002675] Using GB pages for direct mapping hub # [ 0.002819] RAMDISK: [mem 0x7e2e4000-0x7ffcffff] hub # [ 0.002827] ACPI: Early table checksum verification disabled hub # [ 0.002830] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) hub # [ 0.002833] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002838] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002845] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002847] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002849] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002850] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002852] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002853] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002855] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] hub # [ 0.002856] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] hub # [ 0.002856] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002857] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] hub # [ 0.002857] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] hub # [ 0.002858] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] hub # [ 0.002858] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] hub # [ 0.003084] No NUMA configuration found hub # [ 0.003085] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] hub # [ 0.003087] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff] hub # [ 0.005387] Zone ranges: hub # [ 0.005387] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005389] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] hub # [ 0.005390] Normal [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005391] Device empty hub # [ 0.005392] Movable zone start for each node hub # [ 0.005393] Early memory node ranges hub # [ 0.005393] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005394] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.005395] node 0: [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005396] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] hub # [ 0.005417] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.005679] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.077742] On node 0, zone Normal: 40 pages in unavailable ranges hub # [ 0.078224] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.078238] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.078268] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.078271] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.078272] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.078274] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.078275] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.078275] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.078278] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.078279] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.078284] TSC deadline timer available hub # [ 0.078288] CPU topo: Max. logical packages: 1 hub # [ 0.078289] CPU topo: Max. logical dies: 1 hub # [ 0.078289] CPU topo: Max. dies per package: 1 hub # [ 0.078293] CPU topo: Max. threads per core: 1 hub # [ 0.078293] CPU topo: Num. cores per package: 1 hub # [ 0.078294] CPU topo: Num. threads per package: 1 hub # [ 0.078294] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.078316] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.078343] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.078345] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.078346] PM: hibernation: Registered nosave memory: [mem 0x7ffd8000-0xffffffff] hub # [ 0.078347] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.078349] Booting paravirtualized kernel on KVM hub # [ 0.078352] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.083016] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.085697] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.085744] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.085746] Kernel command line: loglevel=4 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/iinrbrwcm8jzlhkn4lcl9279rc8cci4x-nixos-system-hub-test/init regInfo=/nix/.ro-store/cp0ahs3wn2ihxblc2kyd23wddj884nk7-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.085856] Unknown kernel command line parameters "regInfo=/nix/.ro-store/cp0ahs3wn2ihxblc2kyd23wddj884nk7-closure-info/registration", will be passed to user space. hub # [ 0.085869] random: crng init done hub # [ 0.085870] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.090200] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) hub # [ 0.092300] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.092330] software IO TLB: area num 1. hub # [ 0.166248] Fallback order for Node 0: 0 hub # [ 0.166255] Built 1 zonelists, mobility grouping on. Total pages: 1048438 hub # [ 0.166256] Policy zone: Normal hub # [ 0.168762] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.175856] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.184934] allocated 8388608 bytes of page_ext hub # [ 0.195082] ftrace: allocating 48842 entries in 192 pages hub # [ 0.195085] ftrace: allocated 192 pages with 2 groups hub # [ 0.196005] Dynamic Preempt: lazy hub # [ 0.196121] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.196122] rcu: RCU event tracing is enabled. hub # [ 0.196123] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. hub # [ 0.196124] Trampoline variant of Tasks RCU enabled. hub # [ 0.196125] Rude variant of Tasks RCU enabled. hub # [ 0.196125] Tracing variant of Tasks RCU enabled. hub # [ 0.196126] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.196127] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.196185] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.196187] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.196188] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.200499] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.200797] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.200805] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.200913] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.204430] Console: colour VGA+ 80x25 hub # [ 0.204433] printk: legacy console [tty0] enabled hub # [ 0.234911] printk: legacy console [ttyS0] enabled hub # [ 0.346351] ACPI: Core revision 20250807 hub # [ 0.347226] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.348754] APIC: Switch to symmetric I/O mode setup hub # [ 0.349728] x2apic enabled hub # [ 0.350630] APIC: Switched APIC routing to: physical x2apic hub # [ 0.352468] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.353475] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns hub # [ 0.355130] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) hub # [ 0.356213] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.358002] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.358803] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.359874] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.361127] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.363127] Transient Scheduler Attacks: Vulnerable: No microcode hub # [ 0.364127] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.365127] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.366127] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.367134] Spectre V2 : Enabling IBPB for BPF hub # [ 0.368128] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.369127] active return thunk: srso_alias_return_thunk hub # [ 0.370147] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.371127] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.372856] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.373855] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.374870] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.375127] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.376128] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.378128] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.379131] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.380129] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.381923] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.382844] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.383839] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. hub # [ 0.419183] Freeing SMP alternatives memory: 48K hub # [ 0.420026] pid_max: default: 32768 minimum: 301 hub # [ 0.420790] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.422043] landlock: Up and running. hub # [ 0.422593] Yama: becoming mindful. hub # [ 0.423337] LSM support for eBPF active hub # [ 0.424290] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.425201] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.428049] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.428661] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.429133] ... version: 2 hub # [ 0.429864] ... bit width: 48 hub # [ 0.430129] ... generic counters: 6 hub # [ 0.430889] ... generic bitmap: 000000000000003f hub # [ 0.431177] ... fixed-purpose counters: 0 hub # [ 0.431940] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.432892] ... value mask: 0000ffffffffffff hub # [ 0.433129] ... max period: 00007fffffffffff hub # [ 0.434083] ... global_ctrl mask: 000000000000003f hub # [ 0.435012] signal: max sigframe size: 3376 hub # [ 0.435770] rcu: Hierarchical SRCU implementation. hub # [ 0.436132] rcu: Max phase no-delay instances is 400. hub # [ 0.441726] smp: Bringing up secondary CPUs ... hub # [ 0.442144] smp: Brought up 1 node, 1 CPU hub # [ 0.442893] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) hub # [ 0.443352] Memory: 3959892K/4193752K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 220204K reserved, 0K cma-reserved) hub # [ 0.444438] devtmpfs: initialized hub # [ 0.445356] x86/mm: Memory block size: 128MB hub # [ 0.447587] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.448159] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.449215] pinctrl core: initialized pinctrl subsystem hub # [ 0.450350] PM: RTC time: 16:58:26, date: 2026-10-18 hub # [ 0.454245] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.455939] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.457106] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.458693] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.459140] audit: initializing netlink subsys (disabled) hub # [ 0.460330] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.460332] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.461134] audit: type=2000 audit(1792342707.727:1): state=initialized audit_enabled=0 res=1 hub # [ 0.463131] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.463132] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.464129] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.465155] cpuidle: using governor menu hub # [ 0.467424] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.468351] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.469133] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.470142] PCI: Using configuration type 1 for base access hub # [ 0.471265] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.478227] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.479130] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.484131] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.485130] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.495467] ACPI: Added _OSI(Module Device) hub # [ 0.496131] ACPI: Added _OSI(Processor Device) hub # [ 0.496937] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.505601] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.509572] ACPI: Interpreter enabled hub # [ 0.510146] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.510958] ACPI: Using IOAPIC for interrupt routing hub # [ 0.514195] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.515131] PCI: Using E820 reservations for host bridge windows hub # [ 0.518284] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.523446] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.524135] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.525206] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.526252] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.527601] PCI host bridge to bus 0000:00 hub # [ 0.528134] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.529130] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.530130] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.531129] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.532129] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.533129] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.534136] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.535183] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.536581] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.539231] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.540142] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.541151] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.542296] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.543889] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.547816] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] hub # [ 0.548136] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.549152] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] hub # [ 0.550135] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.551704] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.554080] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.554858] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.555152] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] hub # [ 0.556670] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.559174] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.560102] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.560942] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] hub # [ 0.562677] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.564173] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.565085] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.565955] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] hub # [ 0.567180] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.568915] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.572171] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.573153] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] hub # [ 0.574762] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.576168] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.577151] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] hub # [ 0.578722] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.581168] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.582152] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] hub # [ 0.583722] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.585181] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.586153] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] hub # [ 0.587893] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.590939] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.591846] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.592151] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] hub # [ 0.594746] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.597180] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.598136] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.599151] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] hub # [ 0.600720] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.603175] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.604152] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 0.605694] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.606749] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] hub # [ 0.607352] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.608845] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] hub # [ 0.609399] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.610736] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] hub # [ 0.611344] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.612719] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.613374] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.614412] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.615393] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.617544] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] hub # [ 0.618137] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] hub # [ 0.619439] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.620826] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.624321] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.625236] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.626230] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.627226] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.628227] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.629227] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.630230] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.631228] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.632165] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.633143] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.634141] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.635143] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.636163] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.637142] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.638211] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.639339] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.641501] iommu: Default domain type: Translated hub # [ 0.642136] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.643395] ACPI: bus type USB registered hub # [ 0.644198] usbcore: registered new interface driver usbfs hub # [ 0.645143] usbcore: registered new interface driver hub hub # [ 0.646065] usbcore: registered new device driver usb hub # [ 0.647719] NetLabel: Initializing hub # [ 0.648130] NetLabel: domain hash size = 128 hub # [ 0.648879] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.649177] NetLabel: unlabeled traffic allowed by default hub # [ 0.650094] PCI: Using ACPI for IRQ routing hub # [ 0.693610] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 0.694126] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 0.694126] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.694133] vgaarb: loaded hub # [ 0.694873] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.695129] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.699264] clocksource: Switched to clocksource kvm-clock hub # [ 0.702921] VFS: Disk quotas dquot_6.6.0 hub # [ 0.703693] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.705070] pnp: PnP ACPI init hub # [ 0.705926] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 0.706917] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 0.708522] pnp: PnP ACPI: found 5 devices hub # [ 0.716092] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.717611] clocksource: Switched to clocksource acpi_pm hub # [ 0.718628] NET: Registered PF_INET protocol family hub # [ 0.720116] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) hub # [ 0.737584] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) hub # [ 0.739195] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.740636] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.742107] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) hub # [ 0.743412] TCP: Hash tables configured (established 32768 bind 32768) hub # [ 0.744716] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) hub # [ 0.746038] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 0.747354] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 0.748674] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.749675] NET: Registered PF_XDP protocol family hub # [ 0.750570] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.751640] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.752742] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.753918] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 0.755073] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 0.756208] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.758137] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 0.760186] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 0.762188] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 0.764183] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 0.765938] PCI: CLS 0 bytes, default 64 hub # [ 0.766759] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) hub # [ 0.767972] Trying to unpack rootfs image as initramfs... hub # [ 0.773381] software IO TLB: mapped [mem 0x000000007a2e4000-0x000000007e2e4000] (64MB) hub # [ 0.774864] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns hub # [ 0.818672] Initialise system trusted keyrings hub # [ 0.822500] workingset: timestamp_bits=40 max_order=20 bucket_order=0 hub # [ 0.843142] Key type asymmetric registered hub # [ 0.847355] Asymmetric key parser 'x509' registered hub # [ 0.848379] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.852451] io scheduler mq-deadline registered hub # [ 0.853261] io scheduler kyber registered hub # [ 0.856876] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.858165] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.862098] Linux agpgart interface v0.103 hub # [ 0.862951] ACPI: bus type drm_connector registered hub # [ 0.865805] usbcore: registered new interface driver usbserial_generic hub # [ 0.866877] usbserial: USB Serial support registered for generic hub # [ 0.870361] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.870361] Please enable it if your BIOS has the CPPC option. hub # [ 0.872602] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.876471] drop_monitor: Initializing network drop monitor service hub # [ 0.877730] NET: Registered PF_INET6 protocol family hub # [ 0.880899] Segment Routing with IPv6 hub # [ 0.884365] In-situ OAM (IOAM) with IPv6 hub # [ 0.885384] IPI shorthand broadcast: enabled hub # [ 0.893671] sched_clock: Marking stable (744014043, 149321392)->(980869052, -87533617) hub # [ 0.898597] registered taskstats version 1 hub # [ 0.899582] Loading compiled-in X.509 certificates hub # [ 0.919107] Demotion targets for Node 0: null hub # [ 0.922385] Key type .fscrypt registered hub # [ 0.923054] Key type fscrypt-provisioning registered hub # [ 0.924008] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.926356] ima: Allocated hash algorithm: sha1 hub # [ 0.927154] ima: No architecture policies found hub # [ 0.929355] PM: Magic number: 14:517:995 hub # [ 0.930079] memory memory38: hash matches hub # [ 0.933710] RAS: Correctable Errors collector initialized. hub # [ 0.942430] clk: Disabling unused clocks hub # [ 0.943116] PM: genpd: Disabling unused power domains hub # [ 1.112211] Freeing initrd memory: 29616K hub # [ 1.115494] Freeing unused decrypted memory: 2028K hub # [ 1.118264] Freeing unused kernel image (initmem) memory: 3660K hub # [ 1.119602] Write protecting the kernel read-only data: 32768k hub # [ 1.120941] Freeing unused kernel image (text/rodata gap) memory: 296K hub # [ 1.122487] Freeing unused kernel image (rodata/data gap) memory: 684K hub # [ 1.174959] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.176181] Run /init as init process hub # [ 1.187376] systemd[1]: Inserted module 'autofs4' hub # [ 1.207589] fuse: init (API version 7.45) hub # [ 1.215007] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.217620] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.220612] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.222633] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 1.227666] virtiofs virtio5: discovered new tag: nix-store hub # [ 1.229265] virtiofs virtio5: virtio_fs_setup_dax: No cache capability hub # [ 1.236572] virtiofs virtio6: discovered new tag: shared hub # [ 1.238097] virtiofs virtio6: virtio_fs_setup_dax: No cache capability hub # [ 1.241395] virtiofs virtio7: discovered new tag: xchg hub # [ 1.242903] virtiofs virtio7: virtio_fs_setup_dax: No cache capability hub # [ 1.263084] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.599737] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) hub # [ 1.641416] systemd[1]: Detected virtualization kvm. hub # [ 1.643541] systemd[1]: Detected architecture x86-64. hub # [ 1.645649] systemd[1]: Running in initrd. hub # [ 1.648064] systemd[1]: Initializing machine ID from random generator. hub # [ 1.650978] systemd[1]: Hostname set to . hub # [ 1.729139] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.767390] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.770673] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.771841] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.773347] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.774516] systemd[1]: Reached target Path Units. hub # [ 1.775400] systemd[1]: Reached target Slice Units. hub # [ 1.776254] systemd[1]: Reached target Swaps. hub # [ 1.777071] systemd[1]: Reached target Timer Units. hub # [ 1.778058] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.779289] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.780531] systemd[1]: Listening on Journal Sockets. hub # [ 1.781613] systemd[1]: Listening on udev Control Socket. hub # [ 1.782726] systemd[1]: Listening on udev Kernel Socket. hub # [ 1.783769] systemd[1]: Reached target Socket Units. hub # [ 1.785614] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 1.789413] systemd[1]: Starting Load Kernel Module configfs... hub # [ 1.798947] systemd[1]: Starting Journal Service... hub # [ 1.807728] systemd[1]: Starting Load Kernel Modules... hub # [ 1.811415] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 1.816409] systemd[1]: Starting Coldplug All udev Devices... hub # [ 1.829719] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 1.833914] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 1.842731] systemd[1]: Finished Load Kernel Module configfs. hub # [ 1.848784] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 1.851546] systemd-journald[65]: Collecting audit messages is disabled. hub # [ 1.862416] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 1.868552] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 1.879131] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 1.907889] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 1.916539] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 1.926864] systemd[1]: Finished Load Kernel Modules. hub # [ 1.935534] systemd[1]: Starting Apply Kernel Variables... hub # [ 1.955412] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 1.960566] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 1.965434] systemd[1]: Reached target Local File Systems. hub # [ 1.972529] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 1.984446] systemd[1]: Finished Apply Kernel Variables. hub # [ 1.841611] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.992544] systemd[1]: Started Journal Service. hub # hub # [ 1.845320] systemd-modules-load[66]: Inserted module 'virtio_balloon' hub # [ 1.846541] systemd-modules-load[66]: Inserted module 'virtio_gpu' hub # [ 1.862516] systemd[1]: Starting Create System Files and Directories... hub # [ 1.895069] systemd[1]: Finished Create System Files and Directories. hub # [ 1.901667] systemd-udevd[73]: Using default interface naming scheme 'v261'. hub # [ 1.927119] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 1.987083] systemd[1]: Finished Coldplug All udev Devices. hub # [ 1.990134] systemd[1]: Reached target System Initialization. hub # [ 1.990971] systemd[1]: Reached target Basic System. hub # [ 2.379870] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.384892] virtio_blk virtio2: 1/0/0 default/read/poll queues hub # [ 2.403252] virtio_blk virtio2: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) hub # [ 2.409167] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.409957] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.425389] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 2.426147] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 2.428404] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 hub # [ 2.435475] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 2.436800] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 2.438021] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.442365] usb usb1: Product: EHCI Host Controller hub # [ 2.443060] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd hub # [ 2.444952] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 2.447170] hub 1-0:1.0: USB hub found hub # [ 2.449022] hub 1-0:1.0: 6 ports detected hub # [ 2.473031] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 2.491850] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 2.346909] systemd[1]: Starting Virtual Console Setup... hub # [ 2.509535] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 2.514186] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.518477] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 hub # [ 2.372071] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.374397] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.378228] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.537712] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.539013] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.547821] SCSI subsystem initialized hub # [ 2.410400] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.413896] systemd[1]: Finished Virtual Console Setup. hub # [ 2.572204] usb usb2: Product: UHCI Host Controller hub # [ 2.573142] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd hub # [ 2.575081] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 2.580423] hub 2-0:1.0: USB hub found hub # [ 2.434108] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.436574] systemd[1]: Reached target Initrd Root Device. hub # [ 2.440158] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 2.591370] hub 2-0:1.0: 2 ports detected hub # [ 2.603458] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 2.604172] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 2.613130] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 2.617945] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 hub # [ 2.619733] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.622388] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.624413] usb usb3: Product: UHCI Host Controller hub # [ 2.625160] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd hub # [ 2.628410] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 2.630726] hub 3-0:1.0: USB hub found hub # [ 2.632406] hub 3-0:1.0: 2 ports detected hub # [ 2.641048] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 2.493386] systemd-fsck[111]: nixos: clean, 12/262144 files, 37198/1048576 blocks hub # [ 2.645407] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 2.651801] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 2.504564] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.655543] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 hub # [ 2.658725] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.663599] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.668074] usb usb4: Product: UHCI Host Controller hub # [ 2.671771] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd hub # [ 2.673280] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 2.676894] hub 4-0:1.0: USB hub found hub # [ 2.678782] hub 4-0:1.0: 2 ports detected hub # [ 2.687370] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 2.702533] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 2.713180] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 2.715358] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 2.721533] scsi host0: ahci hub # [ 2.722728] scsi host1: ahci hub # [ 2.724431] scsi host2: ahci hub # [ 2.726680] scsi host3: ahci hub # [ 2.728695] scsi host4: ahci hub # [ 2.730473] scsi host5: ahci hub # [ 2.731049] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 47 lpm-pol 1 hub # [ 2.733228] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 47 lpm-pol 1 hub # [ 2.734670] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 47 lpm-pol 1 hub # [ 2.735911] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 47 lpm-pol 1 hub # [ 2.737122] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 47 lpm-pol 1 hub # [ 2.738531] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 47 lpm-pol 1 hub # [ 2.816807] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 2.819357] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 2.821970] usb 1-1: Product: QEMU USB Tablet hub # [ 2.823674] usb 1-1: Manufacturer: QEMU hub # [ 2.825096] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 2.683320] systemd[1]: Mounting /sysroot... hub # [ 2.867209] hid: raw HID events driver (C) Jiri Kosina hub # [ 3.045532] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 3.053452] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 3.055660] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 3.058052] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 3.060549] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 3.062546] ata3.00: applying bridge limits hub # [ 3.064613] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 3.066874] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 3.069158] ata3.00: configured for UDMA/100 hub # [ 3.071732] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 3.146479] usbcore: registered new interface driver usbhid hub # [ 3.147272] usbhid: USB HID core driver hub # [ 3.166490] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 3.177643] 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 hub # [ 3.181508] 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 hub # [ 3.183553] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 3.225803] EXT4-fs (vda): mounted filesystem cb554442-6aa9-49e2-9f0f-f1e9a0878e18 r/w with ordered data mode. Quota mode: none. hub # [ 3.080404] systemd[1]: Mounted /sysroot. hub # [ 3.082250] systemd[1]: Reached target Initrd Root File System. hub # [ 3.084615] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 3.102397] systemd-sysroot-fstab-check[146]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 3.106159] systemd[1]: Reload requested from client PID 146 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 3.108070] systemd[1]: Reloading... hub # [ 3.186559] systemd[1]: Reloading finished in 78 ms. hub # [ 3.195524] systemd-sysroot-fstab-check[146]: Requesting initrd-fs.target/start/replace... hub # [ 3.199105] systemd-sysroot-fstab-check[146]: Requesting swap.target/start/replace... hub # [ 3.202187] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 3.203238] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 3.204386] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 3.683097] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 3.690178] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.698304] systemd[1]: Mounting /sysroot/run... hub # [ 3.710170] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 3.720658] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 3.764749] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 3.766967] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.771412] systemd[1]: Mounted /sysroot/run. hub # [ 3.773703] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.776856] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 3.780291] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 3.791935] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.793413] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.680975] systemd[1]: Mounting /sysroot/nix/store... hub # [ 4.706319] systemd[1]: Mounted /sysroot/nix/store. hub # [ 4.707843] systemd[1]: Reached target Initrd File Systems. hub # [ 4.710140] systemd[1]: Starting Find NixOS closure... hub # [ 4.713366] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 4.734598] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 4.738861] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 4.745863] systemd[1]: Finished Find NixOS closure. hub # [ 4.747198] systemd[1]: Reached target Initrd Default Target. hub # [ 4.749095] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 4.763706] systemd[1]: Stopped target Initrd Default Target. hub # [ 4.765082] systemd[1]: Stopped target Basic System. hub # [ 4.767065] systemd[1]: Stopped target Initrd Root Device. hub # [ 4.767892] systemd[1]: Stopped target Path Units. hub # [ 4.768680] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 4.769816] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 4.771282] systemd[1]: Stopped target Slice Units. hub # [ 4.772075] systemd[1]: Stopped target Socket Units. hub # [ 4.772893] systemd[1]: Stopped target System Initialization. hub # [ 4.773931] systemd[1]: Stopped target Swaps. hub # [ 4.774881] systemd[1]: Stopped target Timer Units. hub # [ 4.775865] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 4.777191] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.778413] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 4.779538] systemd[1]: Stopped Find NixOS closure. hub # [ 4.781278] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.782250] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 4.784351] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.785571] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 4.786812] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.788154] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.789461] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.792127] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.793252] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.794395] systemd[1]: Stopped target Local File Systems. hub # [ 4.795584] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.796821] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 4.798233] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 4.800767] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.801902] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 4.802899] systemd[1]: Stopped Virtual Console Setup. hub # [ 4.815106] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.819174] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 4.827404] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.829690] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 4.831188] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 4.833070] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.834144] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 4.836078] systemd[1]: Closed udev Control Socket. hub # [ 4.837062] systemd[1]: Starting Cleanup udev Database... hub # [ 4.838062] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.839128] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.840124] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.841660] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.842697] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.844135] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 4.860120] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.861432] systemd[1]: Finished Cleanup udev Database. hub # [ 4.862644] systemd[1]: Reached target Switch Root. hub # [ 4.864316] systemd[1]: Starting NixOS Activation... hub # [ 4.935614] initrd-nixos-activation-start[196]: booting system configuration /nix/store/iinrbrwcm8jzlhkn4lcl9279rc8cci4x-nixos-system-hub-test hub # [ 4.963271] initrd-nixos-activation-start[196]: running activation script... hub # [ 5.157749] initrd-nixos-activation-start[219]: setting up /etc... hub # [ 5.265651] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.267317] systemd[1]: Finished NixOS Activation. hub # [ 5.269407] systemd[1]: Starting Switch Root... hub # [ 5.282429] systemd[1]: Switching root. hub # [ 5.556811] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). hub # [ 9.183142] NET: Registered PF_VSOCK protocol family hub # [ 9.575614] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) hub # [ 9.607044] systemd[1]: Detected virtualization kvm. hub # [ 9.609025] systemd[1]: Detected architecture x86-64. hub # [ 9.611055] systemd[1]: Detected first boot. hub # [ 9.615054] systemd[1]: Initializing machine ID from random generator. worker: QEMU running (pid 55) worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.o8JHE0mwMG', fmt=raw size=4294967296 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/1048576 done (finished: start all VMs, in 10.96 seconds) worker # Creating filesystem with 1048576 4k blocks and 262144 inodes hub: waiting for unit multi-user.target worker # Filesystem UUID: c68bf651-6a67-45d8-b42f-4559eb9b8964 hub: waiting for the VM to finish booting worker # Superblock backups stored on blocks: worker # 32768, 98304, 163840, 229376, 294912, 819200, 884736 worker # worker # Allocating group tables: 0/32 done worker # Writing inode tables: 0/32 done worker # Creating journal (16384 blocks): done worker # Writing superblocks and filesystem accounting information: 0/32 done worker # worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. worker # Starting virtiofs daemons... worker # [2026-10-18T16:58:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) worker # [2026-10-18T16:58:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether worker # [2026-10-18T16:58:37Z INFO virtiofsd] Waiting for vhost-user socket connection... worker # [2026-10-18T16:58:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) worker # [2026-10-18T16:58:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether worker # [2026-10-18T16:58:37Z INFO virtiofsd] Waiting for vhost-user socket connection... worker # [2026-10-18T16:58:37Z INFO virtiofsd] Client connected, servicing requests worker # [2026-10-18T16:58:37Z INFO virtiofsd] Client connected, servicing requests worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) worker # worker # worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC510+7EF2C510 CA00 worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:06.0 CB00 PCI2.10 PnP PMM 7EFCC510 7EF2C510 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:06.0)... worker # worker # worker # Booting from ROM... hub # [ 10.556159] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 10.633641] systemd[1]: Applying preset policy. worker # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 worker # [ 0.000000] Command line: loglevel=4 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/911hy7i5w8179vdinkhj4f5xihijzhwv-nixos-system-worker-test/init regInfo=/nix/.ro-store/19ric5ky4nc2as2kbj50cgfbcvsp4gn8-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd4fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd5000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000017fffffff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved worker # [ 0.000000] NX (Execute Disable) protection: active worker # [ 0.000000] APIC: Static calls initialized worker # [ 0.000000] SMBIOS 2.8 present. worker # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 worker # [ 0.000000] DMI: Memory slots populated: 1/1 worker # [ 0.000000] Hypervisor detected: KVM worker # [ 0.000000] last_pfn = 0x7ffd5 max_arch_pfn = 0x10000000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000001] kvm-clock: using sched offset of 477474486 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000006] tsc: Detected 2400.008 MHz processor worker # [ 0.000787] last_pfn = 0x180000 max_arch_pfn = 0x10000000000 worker # [ 0.000817] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000820] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.000859] last_pfn = 0x7ffd5 max_arch_pfn = 0x10000000000 worker # [ 0.002756] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.002768] Using GB pages for direct mapping worker # [ 0.002852] RAMDISK: [mem 0x7e2d2000-0x7ffcffff] worker # [ 0.002858] ACPI: Early table checksum verification disabled worker # [ 0.002862] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) worker # [ 0.002866] ACPI: RSDT 0x000000007FFE248E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002870] ACPI: FACP 0x000000007FFE227E 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002877] ACPI: DSDT 0x000000007FFE0040 00223E (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002879] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002881] ACPI: APIC 0x000000007FFE2372 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002882] ACPI: HPET 0x000000007FFE23F2 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002884] ACPI: MCFG 0x000000007FFE242A 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002885] ACPI: WAET 0x000000007FFE2466 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002887] ACPI: Reserving FACP table memory at [mem 0x7ffe227e-0x7ffe2371] worker # [ 0.002888] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227d] worker # [ 0.002888] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002889] ACPI: Reserving APIC table memory at [mem 0x7ffe2372-0x7ffe23f1] worker # [ 0.002889] ACPI: Reserving HPET table memory at [mem 0x7ffe23f2-0x7ffe2429] worker # [ 0.002890] ACPI: Reserving MCFG table memory at [mem 0x7ffe242a-0x7ffe2465] worker # [ 0.002890] ACPI: Reserving WAET table memory at [mem 0x7ffe2466-0x7ffe248d] worker # [ 0.003115] No NUMA configuration found worker # [ 0.003116] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] worker # [ 0.003119] NODE_DATA(0) allocated [mem 0x17fff8780-0x17fffdcff] worker # [ 0.005400] Zone ranges: worker # [ 0.005401] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.005403] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] worker # [ 0.005404] Normal [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.005405] Device empty worker # [ 0.005406] Movable zone start for each node worker # [ 0.005406] Early memory node ranges worker # [ 0.005407] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005408] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.005409] node 0: [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.005410] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] worker # [ 0.005430] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.005687] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.074263] On node 0, zone Normal: 43 pages in unavailable ranges worker # [ 0.074765] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.074781] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.074812] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 10.834967] systemd[1]: Populated /etc with preset unit settings. worker # [ 0.074815] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.074817] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.074818] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.074819] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.074820] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.074822] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.074823] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.074828] TSC deadline timer available worker # [ 0.074833] CPU topo: Max. logical packages: 1 worker # [ 0.074834] CPU topo: Max. logical dies: 1 worker # [ 0.074834] CPU topo: Max. dies per package: 1 worker # [ 0.074838] CPU topo: Max. threads per core: 1 worker # [ 0.074838] CPU topo: Num. cores per package: 2 worker # [ 0.074839] CPU topo: Num. threads per package: 2 worker # [ 0.074839] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs worker # [ 0.074862] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.074877] kvm-guest: KVM setup pv remote TLB flush worker # [ 0.074880] kvm-guest: setup PV sched yield worker # [ 0.074890] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.074892] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.074893] PM: hibernation: Registered nosave memory: [mem 0x7ffd5000-0xffffffff] worker # [ 0.074894] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.074896] Booting paravirtualized kernel on KVM worker # [ 0.074899] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.079544] setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 worker # [ 0.081674] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u1048576 worker # [ 0.081722] kvm-guest: PV spinlocks enabled worker # [ 0.081723] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) worker # [ 0.081726] Kernel command line: loglevel=4 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/911hy7i5w8179vdinkhj4f5xihijzhwv-nixos-system-worker-test/init regInfo=/nix/.ro-store/19ric5ky4nc2as2kbj50cgfbcvsp4gn8-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.081828] Unknown kernel command line parameters "regInfo=/nix/.ro-store/19ric5ky4nc2as2kbj50cgfbcvsp4gn8-closure-info/registration", will be passed to user space. worker # [ 0.081842] random: crng init done worker # [ 0.081843] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.086157] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) worker # [ 0.088229] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.088280] software IO TLB: area num 2. worker # [ 0.163020] Fallback order for Node 0: 0 worker # [ 0.163029] Built 1 zonelists, mobility grouping on. Total pages: 1048435 worker # [ 0.163032] Policy zone: Normal worker # [ 0.165698] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.172559] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 worker # [ 0.181248] allocated 8388608 bytes of page_ext worker # [ 0.191158] ftrace: allocating 48842 entries in 192 pages worker # [ 0.191160] ftrace: allocated 192 pages with 2 groups worker # [ 0.192008] Dynamic Preempt: lazy worker # [ 0.192174] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.192175] rcu: RCU event tracing is enabled. worker # [ 0.192175] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. worker # [ 0.192177] Trampoline variant of Tasks RCU enabled. worker # [ 0.192177] Rude variant of Tasks RCU enabled. worker # [ 0.192177] Tracing variant of Tasks RCU enabled. worker # [ 0.192178] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.192179] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 worker # [ 0.192196] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.192198] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.192199] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.196579] NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 worker # [ 0.196861] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.196870] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.196979] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.200624] Console: colour VGA+ 80x25 worker # [ 0.200627] printk: legacy console [tty0] enabled worker # [ 0.232950] printk: legacy console [ttyS0] enabled worker # [ 0.337390] ACPI: Core revision 20250807 worker # [ 0.338252] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.339832] APIC: Switch to symmetric I/O mode setup worker # [ 0.340795] x2apic enabled worker # [ 0.341546] APIC: Switched APIC routing to: physical x2apic worker # [ 0.342403] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() worker # [ 0.343551] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() worker # [ 0.344991] kvm-guest: setup PV IPIs worker # [ 0.346501] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.347488] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns worker # [ 0.351631] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) worker # [ 0.353713] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.354772] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.355628] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.356631] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.358628] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.359628] Transient Scheduler Attacks: Vulnerable: No microcode worker # [ 0.361369] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.362331] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.362627] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.364634] Spectre V2 : Enabling IBPB for BPF worker # [ 0.365400] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.366626] active return thunk: srso_alias_return_thunk worker # [ 0.367648] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.368627] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.370459] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.371455] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.372627] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.373626] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' worker # [ 0.374627] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.375628] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.377426] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 worker # [ 0.378423] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 worker # [ 0.379430] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.380418] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.381418] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. worker # [ 0.410598] Freeing SMP alternatives memory: 48K worker # [ 0.411245] pid_max: default: 32768 minimum: 301 worker # [ 0.412297] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.412719] landlock: Up and running. worker # [ 0.414106] Yama: becoming mindful. worker # [ 0.414838] LSM support for eBPF active worker # [ 0.415784] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.416708] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.418707] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.420206] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.420636] ... version: 2 worker # [ 0.421435] ... bit width: 48 worker # [ 0.421630] ... generic counters: 6 worker # [ 0.422369] ... generic bitmap: 000000000000003f worker # [ 0.422629] ... fixed-purpose counters: 0 worker # [ 0.423456] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.424392] ... value mask: 0000ffffffffffff worker # [ 0.424629] ... max period: 00007fffffffffff worker # [ 0.425597] ... global_ctrl mask: 000000000000003f worker # [ 0.426489] signal: max sigframe size: 3376 worker # [ 0.427299] rcu: Hierarchical SRCU implementation. worker # [ 0.427633] rcu: Max phase no-delay instances is 400. worker # [ 0.428690] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level worker # [ 0.434102] smp: Bringing up secondary CPUs ... worker # [ 0.434950] smpboot: x86: Booting SMP configuration: worker # [ 0.435633] .... node #0, CPUs: #1 worker # [ 0.436744] smp: Brought up 1 node, 2 CPUs worker # [ 0.438165] smpboot: Total of 2 processors activated (9600.03 BogoMIPS) worker # [ 0.438940] Memory: 3958488K/4193740K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 220688K reserved, 0K cma-reserved) worker # [ 0.440632] devtmpfs: initialized worker # [ 0.441733] x86/mm: Memory block size: 128MB worker # [ 0.444702] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.445666] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). worker # [ 0.446709] pinctrl core: initialized pinctrl subsystem worker # [ 0.447855] PM: RTC time: 16:58:37, date: 2026-10-18 worker # [ 0.451459] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.453225] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.453662] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.455152] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.455641] audit: initializing netlink subsys (disabled) worker # [ 0.456737] audit: type=2000 audit(1792342718.360:1): state=initialized audit_enabled=0 res=1 worker # [ 0.456890] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.458630] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.459630] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.460630] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.461630] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.462647] cpuidle: using governor menu worker # [ 0.464828] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 11.024606] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 11.025989] systemd[1]: Stopped initrd-switch-root.service. worker # [ 0.465872] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.466634] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.467643] PCI: Using configuration type 1 for base access hub # [ 11.028700] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 0.468863] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 11.030772] systemd[1]: Created slice Slice /system/getty. hub # [ 11.032148] systemd[1]: Created slice User and Session Slice. hub # [ 11.033083] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 11.034273] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 11.035431] systemd[1]: Expecting device /dev/hvc0... hub # [ 11.036095] systemd[1]: Expecting device /dev/ttyS0... worker # [ 0.474671] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 11.036908] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 0.475637] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 11.037793] systemd[1]: Stopped target initrd-fs.target. worker # [ 0.476630] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 11.038588] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 11.039416] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 11.040267] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 11.041191] systemd[1]: Reached target Path Units. worker # [ 0.479630] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 11.041896] systemd[1]: Reached target Remote File Systems. hub # [ 11.042730] systemd[1]: Reached target Slice Units. hub # [ 11.043488] systemd[1]: Reached target Swaps. hub # [ 11.045361] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 11.047921] systemd[1]: Listening on Process Core Dump Socket. worker # [ 0.487269] ACPI: Added _OSI(Module Device) worker # [ 0.487632] ACPI: Added _OSI(Processor Device) hub # [ 11.049652] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 0.488420] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 11.051752] systemd[1]: Listening on Factory Reset Management. hub # [ 11.052760] systemd[1]: Listening on Hostname Service Socket. worker # [ 0.491242] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 11.055575] systemd[1]: Starting Journal Log Access Socket... hub # [ 11.056723] systemd[1]: Listening on Journal Audit Socket. worker # [ 0.493918] ACPI: Interpreter enabled worker # [ 0.495164] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 11.059154] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 0.495631] ACPI: Using IOAPIC for interrupt routing hub # [ 11.060706] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 0.496511] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.497630] PCI: Using E820 reservations for host bridge windows hub # [ 11.061900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 0.498795] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 11.063276] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 11.067337] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 0.503672] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 11.068389] systemd[1]: Listening on udev Control Socket. hub # [ 11.069247] systemd[1]: Listening on udev Varlink Socket. worker # [ 0.504635] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.505719] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 11.071643] systemd[1]: Mounting Huge Pages File System... worker # [ 0.506755] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.508008] PCI host bridge to bus 0000:00 hub # [ 11.073914] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 0.508634] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.509630] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.510630] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.511630] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.512630] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.513630] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] hub # [ 11.080866] systemd[1]: Mounting Kernel Debug File System... worker # [ 0.514630] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.515609] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.517107] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 11.089238] systemd[1]: Mounting Kernel Trace File System... worker # [ 0.519680] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.520643] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.521616] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.522574] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 11.099818] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 0.524415] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.526670] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.527621] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.528653] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] worker # [ 0.529636] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.531375] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 11.113639] systemd[1]: Starting Load Kernel Module configfs... worker # [ 0.533672] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.534550] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.535417] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] worker # [ 0.537239] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.539637] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] hub # [ 11.122216] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 0.540596] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.541435] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] worker # [ 0.543156] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.545550] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.546362] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 11.134584] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 0.546690] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] worker # [ 0.548263] pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.551667] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 11.142628] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 0.552540] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.553389] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] worker # [ 0.554562] pci 0000:00:06.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.556009] pci 0000:00:07.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 11.150427] systemd[1]: Mounting FUSE Control File System... worker # [ 0.558631] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.559653] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] hub # [ 11.153500] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 0.561285] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint worker # [ 0.564632] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.565652] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] hub # [ 11.172462] systemd[1]: Starting Journal Service... worker # [ 0.567263] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint worker # [ 0.569549] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.570383] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] hub # [ 11.179456] systemd[1]: Starting Load Kernel Modules... worker # [ 0.572571] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.575677] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.576579] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.577391] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] worker # [ 0.579163] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 11.190819] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 0.581672] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.582541] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.583391] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] worker # [ 0.585141] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.586673] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.587654] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 11.199409] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 0.589688] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.591360] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] worker # [ 0.591858] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 11.205432] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 0.593354] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] worker # [ 0.593835] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.595380] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] worker # [ 0.595910] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint worker # [ 0.598312] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] hub # [ 11.214456] systemd[1]: Starting Coldplug All udev Devices... worker # [ 0.598927] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.599959] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 0.600901] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint worker # [ 0.602689] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] worker # [ 0.603577] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] worker # [ 0.604971] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.606418] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 11.226217] systemd[1]: Listening on Journal Log Access Socket. worker # [ 0.609978] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 11.230554] systemd-journald[289]: Collecting audit messages is enabled. worker # [ 0.610741] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.611731] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.612740] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 11.234509] systemd[1]: Mounted Huge Pages File System. worker # [ 0.613733] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.614732] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 0.615752] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.616733] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.617666] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.618643] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.619639] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.620643] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 11.242801] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 0.621650] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.622644] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.623646] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.624653] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 11.249838] systemd[1]: Mounted Kernel Debug File System. worker # [ 0.626669] iommu: Default domain type: Translated worker # [ 0.628637] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 11.254625] systemd[1]: Mounted Kernel Trace File System. worker # [ 0.633069] ACPI: bus type USB registered worker # [ 0.635000] usbcore: registered new interface driver usbfs hub # [ 11.258738] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 0.636729] usbcore: registered new interface driver hub worker # [ 0.639667] usbcore: registered new device driver usb hub # [ 11.263678] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 0.643264] NetLabel: Initializing worker # [ 0.643632] NetLabel: domain hash size = 128 worker # [ 0.644362] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.644664] NetLabel: unlabeled traffic allowed by default worker # [ 0.645591] PCI: Using ACPI for IRQ routing hub # [ 11.270254] systemd[1]: Finished Load Kernel Module configfs. hub # [ 11.275163] systemd[1]: Mounted FUSE Control File System. hub # [ 11.281480] loop: module loaded hub # [ 11.282276] systemd[1]: Started Journal Service. hub # [ 11.299333] EXT4-fs (vda): re-mounted cb554442-6aa9-49e2-9f0f-f1e9a0878e18. worker # [ 0.696789] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.697626] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.697626] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.697640] vgaarb: loaded worker # [ 0.698385] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.698630] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.700813] clocksource: Switched to clocksource kvm-clock worker # [ 0.706355] VFS: Disk quotas dquot_6.6.0 worker # [ 0.708125] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 11.188898] systemd-oomd[292]: No swap; memory pressure usage will be degraded worker # [ 0.711264] pnp: PnP ACPI init worker # [ 0.712369] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 0.713407] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 0.715085] pnp: PnP ACPI: found 5 devices worker # [ 0.723830] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.725390] clocksource: Switched to clocksource acpi_pm worker # [ 0.726404] NET: Registered PF_INET protocol family worker # [ 0.727904] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) worker # [ 0.745028] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) worker # [ 0.746569] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.748006] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.750474] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) worker # [ 0.751872] TCP: Hash tables configured (established 32768 bind 32768) worker # [ 0.753095] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) worker # [ 0.754445] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 0.755623] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 0.757029] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.758117] NET: Registered PF_XDP protocol family worker # [ 0.759011] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.760081] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.761148] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.762317] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] worker # [ 0.763483] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 0.764678] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.766667] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 0.768984] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 0.771333] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 0.773647] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 0.775510] PCI: CLS 0 bytes, default 64 worker # [ 0.776408] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) worker # [ 0.776691] Trying to unpack rootfs image as initramfs... worker # [ 0.777490] software IO TLB: mapped [mem 0x000000007a2d2000-0x000000007e2d2000] (64MB) worker # [ 0.777614] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns hub # [ 11.422488] systemd-journald[289]: Received client request to flush runtime journal. worker # [ 0.802341] Initialise system trusted keyrings worker # [ 0.803891] workingset: timestamp_bits=40 max_order=20 bucket_order=0 worker # [ 0.814899] Key type asymmetric registered worker # [ 0.815678] Asymmetric key parser 'x509' registered worker # [ 0.816613] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.818083] io scheduler mq-deadline registered worker # [ 0.818924] io scheduler kyber registered worker # [ 0.821166] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.822519] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.824669] Linux agpgart interface v0.103 worker # [ 0.825501] ACPI: bus type drm_connector registered worker # [ 0.827198] usbcore: registered new interface driver usbserial_generic worker # [ 0.828364] usbserial: USB Serial support registered for generic worker # [ 0.829386] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. worker # [ 0.829386] Please enable it if your BIOS has the CPPC option. worker # [ 0.831745] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.833191] drop_monitor: Initializing network drop monitor service worker # [ 0.834428] NET: Registered PF_INET6 protocol family worker # [ 0.835866] Segment Routing with IPv6 worker # [ 0.836572] In-situ OAM (IOAM) with IPv6 worker # [ 0.838113] IPI shorthand broadcast: enabled worker # [ 0.842628] sched_clock: Marking stable (695012172, 146756829)->(923059618, -81290617) worker # [ 0.844355] registered taskstats version 1 worker # [ 0.845382] Loading compiled-in X.509 certificates worker # [ 0.855795] Demotion targets for Node 0: null worker # [ 0.857881] Key type .fscrypt registered worker # [ 0.858587] Key type fscrypt-provisioning registered worker # [ 0.859596] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.860573] ima: Allocated hash algorithm: sha1 worker # [ 0.861411] ima: No architecture policies found worker # [ 0.862480] PM: Magic number: 14:517:995 worker # [ 0.863285] memory memory38: hash matches worker # [ 0.864858] RAS: Correctable Errors collector initialized. worker # [ 0.869631] clk: Disabling unused clocks worker # [ 0.870367] PM: genpd: Disabling unused power domains worker # [ 1.053891] Freeing initrd memory: 29688K worker # [ 1.061110] Freeing unused decrypted memory: 2028K worker # [ 1.067579] Freeing unused kernel image (initmem) memory: 3660K worker # [ 1.070282] Write protecting the kernel read-only data: 32768k worker # [ 1.073669] Freeing unused kernel image (text/rodata gap) memory: 296K worker # [ 1.077381] Freeing unused kernel image (rodata/data gap) memory: 684K worker # [ 1.144547] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.145685] Run /init as init process worker # [ 1.159184] systemd[1]: Inserted module 'autofs4' worker # [ 1.183775] fuse: init (API version 7.45) worker # [ 1.203694] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.206671] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.211265] ACPI: \_SB_.GSIE: Enabled at IRQ 20 worker # [ 1.217051] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.232514] virtiofs virtio6: discovered new tag: shared worker # [ 1.236491] virtiofs virtio6: virtio_fs_setup_dax: No cache capability worker # [ 1.250289] virtiofs virtio7: discovered new tag: xchg worker # [ 1.254055] virtiofs virtio7: virtio_fs_setup_dax: No cache capability worker # [ 1.298711] systemd[1]: Successfully made /usr/ read-only. hub # [ 11.884301] (udev-worker)[373]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 1.634823] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) worker # [ 1.640065] systemd[1]: Detected virtualization kvm. worker # [ 1.640973] systemd[1]: Detected architecture x86-64. worker # [ 1.641904] systemd[1]: Running in initrd. worker # [ 1.643161] systemd[1]: Initializing machine ID from random generator. worker # [ 1.644419] systemd[1]: Hostname set to . worker # [ 1.721115] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 1.781026] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 1.788803] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.790106] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.791560] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.792783] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.793957] systemd[1]: Reached target Path Units. worker # [ 1.794897] systemd[1]: Reached target Slice Units. worker # [ 1.795849] systemd[1]: Reached target Swaps. worker # [ 1.796689] systemd[1]: Reached target Timer Units. worker # [ 1.797793] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 1.799065] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 1.800279] systemd[1]: Listening on Journal Sockets. worker # [ 1.801361] systemd[1]: Listening on udev Control Socket. worker # [ 1.802415] systemd[1]: Listening on udev Kernel Socket. worker # [ 1.803384] systemd[1]: Reached target Socket Units. worker # [ 1.805561] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 1.807698] systemd[1]: Starting Load Kernel Module configfs... worker # [ 1.814865] systemd[1]: Starting Journal Service... worker # [ 1.820046] systemd[1]: Starting Load Kernel Modules... worker # [ 1.821104] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.828014] systemd[1]: Starting Coldplug All udev Devices... worker # [ 1.833280] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 1.835109] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 1.836733] systemd[1]: Finished Load Kernel Module configfs. worker # [ 1.838308] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 1.849845] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 1.860789] systemd-journald[73]: Collecting audit messages is disabled. hub # [ 12.493612] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 hub # [ 12.496863] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 1.880878] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 1.884858] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 1.890984] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 1.893817] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 1.901837] systemd[1]: Finished Load Kernel Modules. worker # [ 1.905546] systemd[1]: Starting Apply Kernel Variables... worker # [ 1.910922] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 1.914006] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 1.916844] systemd[1]: Reached target Local File Systems. worker # [ 1.923847] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 1.781642] systemd-modules-load[74]: Using 2 probe threads[ 1.929332] systemd[1]: Started Journal Service. worker # worker # [ 1.784493] systemd-modules-load[74]: Inserted module 'virtio_balloon' worker # [ 1.787192] systemd-modules-load[74]: Inserted module 'virtio_gpu' worker # [ 1.788384] systemd-modules-load[74]: Inserted module 'dm_mod' worker # [ 1.790503] systemd[1]: Finished Apply Kernel Variables. worker # [ 1.793969] systemd[1]: Starting Create System Files and Directories... worker # [ 1.810796] systemd[1]: Finished Create System Files and Directories. worker # [ 1.821456] systemd-udevd[83]: Using default interface naming scheme 'v261'. worker # [ 1.835364] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 1.848844] systemd[1]: Finished Coldplug All udev Devices. worker # [ 1.850127] systemd[1]: Reached target System Initialization. worker # [ 1.851132] systemd[1]: Reached target Basic System. worker # [ 2.128069] virtio_blk virtio2: 2/0/0 default/read/poll queues hub # [ 12.501555] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input3 hub # [ 12.519029] ACPI: button: Power Button [PWRF] hub # [ 12.620912] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 2.132092] virtio_blk virtio2: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) worker # [ 2.138915] virtio_blk virtio3: 2/0/0 default/read/poll queues worker # [ 2.140863] virtio_blk virtio3: [vdb] 2666000 512-byte logical blocks (1.36 GB/1.27 GiB) worker # [ 2.146984] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.149786] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.150650] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.168035] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 2.169405] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1 worker # [ 2.187712] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 2.198180] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 worker # [ 2.203677] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.060233] systemd[1]: Starting Virtual Console Setup... worker # [ 2.213689] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.068673] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.217404] usb usb1: Product: UHCI Host Controller hub # [ 12.718748] rtc_cmos PNP0B00:00: RTC can wake from S4 hub # [ 12.723897] rtc_cmos PNP0B00:00: registered as rtc0 hub # [ 12.723975] rtc_cmos PNP0B00:00: setting system clock to 2026-10-18T16:58:39 UTC (1792342719) worker # [ 2.072449] (udev-worker)[113]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.221195] usb usb1: Manufacturer: Linux 6.18.56 uhci_hcd worker # [ 2.221546] SCSI subsystem initialized worker # [ 2.222012] usb usb1: SerialNumber: 0000:00:1d.0 worker # [ 2.077304] (udev-worker)[113]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.091234] systemd-vconsole-setup[116]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.093351] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.240081] hub 1-0:1.0: USB hub found worker # [ 2.242424] hub 1-0:1.0: 2 ports detected worker # [ 2.096725] systemd[1]: Finished Virtual Console Setup. worker # [ 2.247146] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 2.101086] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.248702] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2 worker # [ 2.103152] systemd[1]: Reached target Initrd Root Device. worker # [ 2.251851] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 worker # [ 2.106346] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.257796] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 12.724056] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 12.724629] systemd-journald[289]: Time jumped backwards, rotating. worker # [ 2.258685] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 12.740889] mousedev: PS/2 mouse device common for all mice worker # [ 2.259885] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.260946] usb usb2: Product: EHCI Host Controller worker # [ 2.261661] usb usb2: Manufacturer: Linux 6.18.56 ehci_hcd worker # [ 2.262418] usb usb2: SerialNumber: 0000:00:1d.7 worker # [ 2.263424] hub 2-0:1.0: USB hub found worker # [ 2.264161] hub 2-0:1.0: 6 ports detected worker # [ 2.130354] systemd-fsck[124]: nixos: clean, 12/262144 files, 37198/1048576 blocks worker # [ 2.134482] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.285988] hub 1-0:1.0: USB hub found worker # [ 2.286660] hub 1-0:1.0: 2 ports detected worker # [ 2.287557] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 2.288323] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 2.295993] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 2.297405] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.301023] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 hub # [ 12.757461] Console: switching to colour dummy device 80x25 hub # [ 12.933717] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 12.933720] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 2.308494] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.309742] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.310861] usb usb3: Product: UHCI Host Controller worker # [ 2.311590] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd hub # [ 12.940818] parport_pc 00:02: reported by Plug and Play ACPI hub # [ 12.941492] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 2.320256] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 2.323817] hub 3-0:1.0: USB hub found worker # [ 2.324729] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 2.324788] hub 3-0:1.0: 2 ports detected hub # [ 12.954588] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 2.326013] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 12.955925] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt hub # [ 12.956631] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 2.327812] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 2.328345] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 12.957473] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 2.329978] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 2.331381] scsi host0: ahci worker # [ 2.331963] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 12.810869] systemd-ssh-issue[529]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # [ 2.332906] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 worker # [ 2.333881] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.335077] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.336180] usb usb4: Product: UHCI Host Controller worker # [ 2.336362] scsi host1: ahci worker # [ 2.336387] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd worker # [ 2.338223] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 2.338273] scsi host2: ahci worker # [ 2.338642] hub 4-0:1.0: USB hub found worker # [ 2.340336] hub 4-0:1.0: 2 ports detected worker # [ 2.340822] scsi host3: ahci worker # [ 2.343147] scsi host4: ahci hub # [ 12.977111] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 2.351132] scsi host5: ahci hub # [ 12.979789] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 2.355102] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 48 lpm-pol 1 worker # [ 2.357185] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 48 lpm-pol 1 worker # [ 2.358600] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 48 lpm-pol 1 worker # [ 2.359812] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 48 lpm-pol 1 worker # [ 2.360996] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 48 lpm-pol 1 worker # [ 2.362229] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 48 lpm-pol 1 hub # [ 13.065016] Console: switching to colour frame buffer device 160x50 worker # [ 2.504025] usb 2-1: new high-speed USB device number 2 using ehci-pci hub # [ 13.159720] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device hub # connecting to host... hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 3.14 seconds) hub: (finished: waiting for the VM to finish booting, in 3.14 seconds) worker # [ 2.635340] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 2.638348] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 2.641045] usb 2-1: Product: QEMU USB Tablet worker # [ 2.642691] usb 2-1: Manufacturer: QEMU worker # [ 2.644223] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 13.284891] ppdev: user-space parallel port driver worker # [ 2.671954] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 2.678998] hid: raw HID events driver (C) Jiri Kosina worker # [ 2.685826] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 2.688070] ata2: SATA link down (SStatus 0 SControl 300) worker # [ 2.689927] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 2.692131] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 2.694146] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 2.696462] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 2.698520] ata3.00: applying bridge limits worker # [ 2.700359] ata3.00: configured for UDMA/100 hub # [ 13.350324] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 2.702706] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 13.376869] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 2.761863] usbcore: registered new interface driver usbhid worker # [ 2.763911] usbhid: USB HID core driver worker # [ 2.775679] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 2.779184] 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 worker # [ 2.785186] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 2.817039] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 2.689294] systemd[1]: Mounting /sysroot... worker # [ 2.985493] EXT4-fs (vda): mounted filesystem c68bf651-6a67-45d8-b42f-4559eb9b8964 r/w with ordered data mode. Quota mode: none. worker # [ 2.843834] systemd[1]: Mounted /sysroot. worker # [ 2.844837] systemd[1]: Reached target Initrd Root File System. worker # [ 2.847927] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 2.849804] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 2.855230] systemd[1]: Mounting /sysroot/run... worker # [ 2.859881] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 2.863165] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 2.866833] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 13.648227] kvm_amd: TSC scaling supported worker # [ 2.879928] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 13.656137] kvm_amd: Nested Virtualization enabled worker # [ 3.028929] erofs (device vdb): mounted with root inode @ nid 36. hub # [ 13.658467] kvm_amd: Nested Paging enabled hub # [ 13.658856] kvm_amd: LBR virtualization supported hub # [ 13.662948] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 2.888339] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 13.664990] kvm_amd: Virtual GIF supported worker # [ 2.893052] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 13.668334] kvm_amd: Virtual NMI enabled worker # [ 2.896648] systemd-sysroot-fstab-check[167]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 2.898341] systemd[1]: Mounted /sysroot/run. worker # [ 2.899592] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 2.900532] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 2.901651] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 2.902980] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 2.904218] systemd[1]: Reload requested from client PID 167 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 2.905717] systemd[1]: Reloading... worker # [ 2.968942] systemd[1]: Reloading finished in 64 ms. hub # [ 13.754941] EDAC MC: Ver: 3.0.0 worker # [ 2.989815] systemd-sysroot-fstab-check[167]: Requesting initrd-fs.target/start/replace... worker # [ 2.992879] systemd-sysroot-fstab-check[167]: Requesting swap.target/start/replace... worker # [ 2.997117] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 2.998375] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 2.999743] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.001343] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.023910] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.025427] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 14.090842] 8021q: 802.1Q VLAN Support v1.8 hub # [ 14.091381] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 14.203081] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 14.228011] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 14.228743] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 14.232204] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 14.233015] cfg80211: failed to load regulatory.db hub # [ 14.277025] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 14.145675] systemd-vconsole-setup[630]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 3.689938] systemd[1]: Mounting /sysroot/nix/store... worker # [ 3.743514] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.746407] systemd[1]: Reached target Initrd File Systems. worker # [ 3.750077] systemd[1]: Starting Find NixOS closure... worker # [ 3.752215] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 3.794136] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 3.796649] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 3.813280] systemd[1]: Finished Find NixOS closure. worker # [ 3.815287] systemd[1]: Reached target Initrd Default Target. worker # [ 3.817459] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 3.834140] systemd[1]: Stopped target Initrd Default Target. worker # [ 3.835748] systemd[1]: Stopped target Basic System. worker # [ 3.837046] systemd[1]: Stopped target Initrd Root Device. worker # [ 3.839616] systemd[1]: Stopped target Path Units. worker # [ 3.841450] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 3.846501] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 3.848723] systemd[1]: Stopped target Slice Units. worker # [ 3.849825] systemd[1]: Stopped target Socket Units. worker # [ 3.854816] systemd[1]: Stopped target System Initialization. worker # [ 3.856851] systemd[1]: Stopped target Swaps. worker # [ 3.857965] systemd[1]: Stopped target Timer Units. worker # [ 3.859053] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 3.860479] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 3.861799] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 3.864339] systemd[1]: Stopped Find NixOS closure. worker # [ 3.866044] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.869229] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 3.870412] systemd[1]: Stopped Apply Kernel Variables. worker # [ 3.871289] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 3.872361] systemd[1]: Stopped Load Kernel Modules. worker # [ 3.873552] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 3.874700] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 3.875918] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 3.877044] systemd[1]: Stopped Create System Files and Directories. worker # [ 3.877936] systemd[1]: Stopped target Local File Systems. worker # [ 3.878759] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 3.879693] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 3.880704] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 3.881629] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 3.882703] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 3.883724] systemd[1]: Stopped Virtual Console Setup. worker # [ 3.886171] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 3.887237] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 3.888460] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.889556] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.890445] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 3.891360] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 3.892381] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 3.893376] systemd[1]: Closed udev Control Socket. worker # [ 3.894159] systemd[1]: Starting Cleanup udev Database... worker # [ 3.894933] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 3.896136] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 3.897115] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 3.898239] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 3.899259] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 3.900332] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 3.901252] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 3.902304] systemd[1]: Finished Cleanup udev Database. worker # [ 3.903099] systemd[1]: Reached target Switch Root. worker # [ 3.903818] systemd[1]: Starting NixOS Activation... worker # [ 3.972460] initrd-nixos-activation-start[213]: booting system configuration /nix/store/911hy7i5w8179vdinkhj4f5xihijzhwv-nixos-system-worker-test worker # [ 3.993733] initrd-nixos-activation-start[213]: running activation script... worker # [ 4.172689] initrd-nixos-activation-start[236]: setting up /etc... worker # [ 4.294239] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.295501] systemd[1]: Finished NixOS Activation. worker # [ 4.298137] systemd[1]: Starting Switch Root... worker # [ 4.316718] systemd[1]: Switching root. worker # [ 4.511936] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). hub # [ 15.181804] NET: Registered PF_PACKET protocol family worker # [ 4.709905] NET: Registered PF_VSOCK protocol family worker # [ 5.087337] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) worker # [ 5.097231] systemd[1]: Detected virtualization kvm. worker # [ 5.099061] systemd[1]: Detected architecture x86-64. worker # [ 5.101054] systemd[1]: Detected first boot. worker # [ 5.103733] systemd[1]: Initializing machine ID from random generator. worker # [ 5.245343] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 5.374828] systemd[1]: Applying preset policy. worker # [ 5.518462] systemd[1]: Populated /etc with preset unit settings. worker # [ 5.619106] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.622153] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.627180] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.632641] systemd[1]: Created slice Slice /system/getty. worker # [ 5.636458] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 5.640555] systemd[1]: Created slice User and Session Slice. worker # [ 5.642993] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 5.646068] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.648847] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.650673] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.652591] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.654797] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.656868] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.658927] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.661141] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.663342] systemd[1]: Reached target Path Units. worker # [ 5.664849] systemd[1]: Reached target Remote File Systems. worker # [ 5.666461] systemd[1]: Reached target Slice Units. worker # [ 5.668020] systemd[1]: Reached target Swaps. worker # [ 5.670892] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.674650] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.677317] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.679779] systemd[1]: Listening on Factory Reset Management. worker # [ 5.680778] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.683227] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.684840] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.689522] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 5.692404] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.695239] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.698475] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 5.705029] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.707595] systemd[1]: Listening on udev Control Socket. worker # [ 5.709849] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.715293] systemd[1]: Mounting Huge Pages File System... worker # [ 5.721943] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 5.728055] systemd[1]: Mounting Kernel Debug File System... worker # [ 5.732310] systemd[1]: Mounting Kernel Trace File System... worker # [ 5.742813] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 5.757150] systemd[1]: Starting Load Kernel Module configfs... worker # [ 5.758052] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 5.759523] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 5.761070] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.773895] systemd[1]: Mounting FUSE Control File System... worker # [ 5.774855] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 5.784830] systemd[1]: Starting Journal Service... worker # [ 5.788868] systemd[1]: Starting Load Kernel Modules... worker # [ 5.793833] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 5.796532] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 5.797460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.806977] systemd[1]: Starting Coldplug All udev Devices... worker # [ 5.810718] systemd[1]: Listening on Journal Log Access Socket. worker # [ 5.812521] systemd[1]: Mounted Huge Pages File System. worker # [ 5.813406] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 5.815975] systemd[1]: Mounted Kernel Debug File System. worker # [ 5.816443] systemd-journald[307]: Collecting audit messages is enabled. worker # [ 5.816916] systemd[1]: Mounted Kernel Trace File System. worker # [ 5.822165] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 5.823426] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 5.823779] EXT4-fs (vda): re-mounted c68bf651-6a67-45d8-b42f-4559eb9b8964. worker # [ 5.824977] systemd[1]: Finished Load Kernel Module configfs. worker # [ 5.827654] systemd[1]: Mounted FUSE Control File System. worker # [ 5.829714] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 5.831543] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 5.837021] systemd[1]: Mounting Kernel Configuration File System... worker # [ 5.837981] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 5.840991] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 5.848273] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 5.849342] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.850672] loop: module loaded worker # [ 5.852623] systemd[1]: Mounted Kernel Configuration File System. worker # [ 5.854915] systemd[1]: Started Journal Service. worker # [ 5.912562] systemd-journald[307]: Received client request to flush runtime journal. worker # [ 5.840677] systemd-oomd[310]: No swap; memory pressure usage will be degraded worker # [ 6.089939] (udev-worker)[412]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 6.273649] mousedev: PS/2 mouse device common for all mice worker # [ 6.298634] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 6.302581] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 6.303493] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.314152] Console: switching to colour dummy device 80x25 worker # [ 6.320230] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 6.320232] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 6.323902] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 6.324608] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 6.325993] ACPI: button: Power Button [PWRF] worker # [ 6.351631] rtc_cmos PNP0B00:00: RTC can wake from S4 worker # [ 6.352901] rtc_cmos PNP0B00:00: registered as rtc0 worker # [ 6.352973] rtc_cmos PNP0B00:00: setting system clock to 2026-10-18T16:58:43 UTC (1792342723) worker # [ 6.353377] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 6.358452] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 6.358583] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 6.370975] Console: switching to colour frame buffer device 160x50 worker # [ 6.373521] systemd-journald[307]: Time jumped backwards, rotating. worker # [ 6.374779] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 6.400265] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:07.0/virtio5/input/input4 worker # [ 6.413389] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 6.425901] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 6.426582] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 6.438059] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 6.494613] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 6.501774] ppdev: user-space parallel port driver worker # [ 6.502844] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 6.431424] systemd-vconsole-setup[478]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 6.628507] kvm_amd: TSC scaling supported worker # [ 6.629057] kvm_amd: Nested Virtualization enabled worker # [ 6.629562] kvm_amd: Nested Paging enabled worker # [ 6.630026] kvm_amd: LBR virtualization supported worker # [ 6.630557] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 6.631101] kvm_amd: Virtual GIF supported worker # [ 6.631586] kvm_amd: Virtual NMI enabled worker # [ 6.691684] EDAC MC: Ver: 3.0.0 worker # [ 6.826654] systemd-ssh-issue[556]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # connecting to host... worker # [ 7.320427] 8021q: 802.1Q VLAN Support v1.8 worker # [ 7.323549] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 7.403009] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 7.409937] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 7.411415] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 7.414200] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 7.415294] cfg80211: failed to load regulatory.db worker # [ 7.442928] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 7.506316] NET: Registered PF_PACKET protocol family hub: (finished: waiting for unit multi-user.target, in 11.07 seconds) worker: waiting for unit multi-user.target worker: waiting for the VM to finish booting worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 0.00 seconds) worker: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker: (finished: waiting for unit multi-user.target, in 3.19 seconds) subtest: certificate authority hub: must succeed: tribuchet ca init --dir /root/ca hub: (finished: must succeed: tribuchet ca init --dir /root/ca, in 0.05 seconds) hub: must succeed: tribuchet ca issue hub --dir /root/ca hub: (finished: must succeed: tribuchet ca issue hub --dir /root/ca, in 0.03 seconds) hub: must succeed: tribuchet ca issue worker --dir /root/ca hub: (finished: must succeed: tribuchet ca issue worker --dir /root/ca, in 0.02 seconds) hub: must succeed: mkdir -p /etc/tribuchet/ca hub: (finished: must succeed: mkdir -p /etc/tribuchet/ca, in 0.01 seconds) hub: must succeed: cp /root/ca/hub.crt /root/ca/hub.key /root/ca/ca.crt /etc/tribuchet/ca/ hub: (finished: must succeed: cp /root/ca/hub.crt /root/ca/hub.key /root/ca/ca.crt /etc/tribuchet/ca/, in 0.01 seconds) worker: must succeed: mkdir -p /etc/tribuchet/tls worker: (finished: must succeed: mkdir -p /etc/tribuchet/tls, in 0.02 seconds) hub: must succeed: cat /root/ca/worker.crt hub: (finished: must succeed: cat /root/ca/worker.crt, in 0.01 seconds) worker: must succeed: cat > /etc/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBWTCB/6ADAgECAhRhp9qwSLnrAJEEsgB3BXuLMaquTjAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MTAxODE2NTg1 MVoXDTI4MTAxNzE2NTg1MVowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABGYv2S2ei8jtzurlErhGWca7 2rPsXkulROlT3yXaPL5ACqtChRpEThxXuNonKAVUTUuJXCzcYOEuKHR+U8JHF+Kj FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNJADBGAiEA388qfY+0 3QMqxJCj6OIqEgZq3QhiTDxXo6gBHKDlV1ACIQCvHERsa5Klj9AFQGS2uVbrIk0J LWVVNwRZpP35kDdQ4w== -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBWTCB/6ADAgECAhRhp9qwSLnrAJEEsgB3BXuLMaquTjAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MTAxODE2NTg1 MVoXDTI4MTAxNzE2NTg1MVowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABGYv2S2ei8jtzurlErhGWca7 2rPsXkulROlT3yXaPL5ACqtChRpEThxXuNonKAVUTUuJXCzcYOEuKHR+U8JHF+Kj FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNJADBGAiEA388qfY+0 3QMqxJCj6OIqEgZq3QhiTDxXo6gBHKDlV1ACIQCvHERsa5Klj9AFQGS2uVbrIk0J LWVVNwRZpP35kDdQ4w== -----END CERTIFICATE----- PEMEOF, in 0.02 seconds) hub: must succeed: cat /root/ca/worker.key hub: (finished: must succeed: cat /root/ca/worker.key, in 0.01 seconds) worker: must succeed: cat > /etc/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgW5cSUPeO/wW8mWDC JXLCQo6MDdT0IWPJw+qw2eAUFCKhRANCAARmL9ktnovI7c7q5RK4RlnGu9qz7F5L pUTpU98l2jy+QAqrQoUaRE4cV7jaJygFVE1LiVws3GDhLih0flPCRxfi -----END PRIVATE KEY----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgW5cSUPeO/wW8mWDC JXLCQo6MDdT0IWPJw+qw2eAUFCKhRANCAARmL9ktnovI7c7q5RK4RlnGu9qz7F5L pUTpU98l2jy+QAqrQoUaRE4cV7jaJygFVE1LiVws3GDhLih0flPCRxfi -----END PRIVATE KEY----- PEMEOF, in 0.01 seconds) hub: must succeed: cat /root/ca/ca.crt hub: (finished: must succeed: cat /root/ca/ca.crt, in 0.01 seconds) worker: must succeed: cat > /etc/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBjzCCATWgAwIBAgIUUFBz41556ekUtRezEP/19SZ1iZAwCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjEwMTgxNjU4 NTFaFw0zNjEwMTUxNjU4NTFaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAATo9xZxKpyWyx5/0ZYJ9B/s xEJyEOCA+BKkwu8QW+RUw8nU6C00/gnAF9DvmYuKRePP++YalyoteixY2Rm1zA/Y o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFDTPG1a6uneC WDSOVbf0eMu6+EAQMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIh AJXS6XrUWVX8sbHIEifunrWQcp/lHomMf4TAAoP1jffAAiAhTyeBYu34rXIKbZr7 HDFFEnq150n2vcnYnn0AEeR5Hg== -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBjzCCATWgAwIBAgIUUFBz41556ekUtRezEP/19SZ1iZAwCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjEwMTgxNjU4 NTFaFw0zNjEwMTUxNjU4NTFaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAATo9xZxKpyWyx5/0ZYJ9B/s xEJyEOCA+BKkwu8QW+RUw8nU6C00/gnAF9DvmYuKRePP++YalyoteixY2Rm1zA/Y o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFDTPG1a6uneC WDSOVbf0eMu6+EAQMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIh AJXS6XrUWVX8sbHIEifunrWQcp/lHomMf4TAAoP1jffAAiAhTyeBYu34rXIKbZr7 HDFFEnq150n2vcnYnn0AEeR5Hg== -----END CERTIFICATE----- PEMEOF, in 0.02 seconds) worker: must succeed: chmod 600 /etc/tribuchet/tls/worker.key worker: (finished: must succeed: chmod 600 /etc/tribuchet/tls/worker.key, in 0.01 seconds) (finished: subtest: certificate authority, in 0.23 seconds) subtest: worker registers at hub over mTLS hub: must succeed: systemctl start tribuchet-hub.socket hub: (finished: must succeed: systemctl start tribuchet-hub.socket, in 0.03 seconds) hub: must succeed: systemctl start tribuchet-hub hub # [ 24.520400] tribuchet[907]: 2026-10-18T16:58:51.445281Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 24.524186] tribuchet[907]: 2026-10-18T16:58:51.449454Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub: (finished: must succeed: systemctl start tribuchet-hub, in 0.05 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 13.975961] tribuchet[899]: 2026-10-18T16:58:51.269084Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/etc/tribuchet/tls/ca.crt", cert: "/etc/tribuchet/tls/worker.crt", key: "/run/credentials/tribuchet-worker.service/worker-key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 1048576, sandbox_bin_sh: None, build_memory_max_bytes: Some(2147483648), max_jobs: 2, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {"aarch64-linux": "/nix/store/0ap7cqwsrl7k49pfbrx54v5x778g0rsv-qemu-user-static-x86_64-unknown-linux-musl-11.1.2/bin/qemu-aarch64"}, fod_network: NetPolicy { default: Allow, rules: [Rule { action: Deny, proto: Tcp, dst: Any, ports: [PortRange { start: 8766, end: 8766 }] }] }, recursive_nix: true, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 13.995293] tribuchet[899]: 2026-10-18T16:58:51.288626Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.10 seconds) worker: must succeed: systemctl is-active tribuchet-agent@1.socket tribuchet-agent@2.socket worker: (finished: must succeed: systemctl is-active tribuchet-agent@1.socket tribuchet-agent@2.socket, in 0.01 seconds) worker: must fail: systemctl is-active tribuchet-agent@3.socket worker: (finished: must fail: systemctl is-active tribuchet-agent@3.socket, in 0.01 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered' worker # [ 14.098084] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[914]: 2026-10-18T16:58:51.391111Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 14.104821] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[914]: 2026-10-18T16:58:51.391290Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 14.109636] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[914]: 2026-10-18T16:58:51.391344Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 14.114926] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[914]: 2026-10-18T16:58:51.395181Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 14.179383] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[922]: 2026-10-18T16:58:51.472844Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 14.185974] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[922]: 2026-10-18T16:58:51.474381Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 14.193245] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[922]: 2026-10-18T16:58:51.474417Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 14.198807] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[922]: 2026-10-18T16:58:51.474534Z INFO tribuchet::worker::agent: no build held, exiting until the next activation hub # [ 24.825802] tribuchet[907]: 2026-10-18T16:58:51.750434Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] worker # [ 14.240035] tribuchet[899]: 2026-10-18T16:58:51.533683Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered', in 1.08 seconds) ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/2bhsk8wfsfr8v5d88sjwrmfb3mv2fxwa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker: waiting for success: test $(systemctl list-units --state=active --no-legend 'tribuchet-agent@*.service' | wc -l) = 0 ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/2bhsk8wfsfr8v5d88sjwrmfb3mv2fxwa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker: (finished: waiting for success: test $(systemctl list-units --state=active --no-legend 'tribuchet-agent@*.service' | wc -l) = 0, in 0.03 seconds) (finished: subtest: worker registers at hub over mTLS, in 1.31 seconds) subtest: worker sshd reachable for the harness backdoor hub: waiting for unit sshd.service hub: (finished: waiting for unit sshd.service, in 0.04 seconds) worker: waiting for unit sshd.service worker: (finished: waiting for unit sshd.service, in 0.03 seconds) (finished: subtest: worker sshd reachable for the harness backdoor, in 0.07 seconds) subtest: daemon lifecycle running 1 test test lifecycle ... hub # [ 26.095489] systemd[936]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 26.188604] systemd[936]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 15.936692] systemd[946]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 16.011744] systemd[946]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 27.421219] tribuchet[907]: 2026-10-18T16:58:54.346060Z INFO tribuchet::hub::submit: queueing build id="b867910df781b1c6724d19de25a8d2e2" system="x86_64-linux" hub # [ 27.423887] tribuchet[907]: 2026-10-18T16:58:54.348969Z INFO tribuchet::hub: dispatching build id="b867910df781b1c6724d19de25a8d2e2" worker="worker" worker # [ 16.802583] tribuchet[899]: 2026-10-18T16:58:54.095514Z INFO tribuchet::worker::session: build assigned id="b867910df781b1c6724d19de25a8d2e2" worker # [ 16.871631] nix-daemon[963]: accepted connection from pid 899, user tribuchet (trusted) hub # [ 27.503412] tribuchet[907]: 2026-10-18T16:58:54.428060Z INFO tribuchet::hub::relay::staging: input path negotiation done id="b867910df781b1c6724d19de25a8d2e2" total=8 missing=1 hub # [ 27.569539] nix-daemon[1002]: accepted connection from pid 907, user root (trusted) worker # [ 16.957209] nix-daemon[963]: accepted connection from pid 899, user tribuchet (trusted) worker # [ 16.967669] tribuchet[899]: 2026-10-18T16:58:54.261359Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="b867910df781b1c6724d19de25a8d2e2" fixed_output=false network=false net_isolation=false worker # [ 17.064583] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[975]: 2026-10-18T16:58:54.357963Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 17.070077] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[975]: 2026-10-18T16:58:54.358904Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 17.072815] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[975]: 2026-10-18T16:58:54.358952Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 17.078669] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[975]: 2026-10-18T16:58:54.372388Z INFO tribuchet::worker::agent: builder started id="b867910df781b1c6724d19de25a8d2e2" pid=981 worker # [ 17.081406] tribuchet[899]: 2026-10-18T16:58:54.372465Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="b867910df781b1c6724d19de25a8d2e2" pid=981 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/9aa565ece441b17d/build worker # [ 17.093804] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[975]: 2026-10-18T16:58:54.386838Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14 cpu_usec=5888 peak_memory_bytes=999424 worker # [ 17.279431] tribuchet[899]: 2026-10-18T16:58:54.572935Z INFO tribuchet::worker::build::agent_exec: builder finished id="b867910df781b1c6724d19de25a8d2e2" exit_code=0 aborted=None worker # [ 17.296709] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[975]: 2026-10-18T16:58:54.590414Z INFO tribuchet::worker::agent: cleanup done id="b867910df781b1c6724d19de25a8d2e2" worker # [ 17.420209] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[996]: 2026-10-18T16:58:54.713597Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 17.423170] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[996]: 2026-10-18T16:58:54.714839Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 17.425668] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[996]: 2026-10-18T16:58:54.714874Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 17.427951] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[996]: 2026-10-18T16:58:54.714919Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 17.484871] tribuchet[899]: 2026-10-18T16:58:54.778551Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="b867910df781b1c6724d19de25a8d2e2" hub # [ 28.111155] tribuchet[907]: 2026-10-18T16:58:55.036086Z INFO tribuchet::hub::relay: build usage id="b867910df781b1c6724d19de25a8d2e2" key="2556de5e8b63646eea80f26d646fd9ef83ea4c5643e4280fad9aefb1e78f7cc4" exit_code=0 wall_ms=14 cpu_usec=5888 peak_memory_bytes=999424 oom_killed=false worker # [ 17.499411] tribuchet[899]: 2026-10-18T16:58:54.793105Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="b867910df781b1c6724d19de25a8d2e2" hub # [ 28.498554] tribuchet[907]: 2026-10-18T16:58:55.423436Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 17.876827] tribuchet[899]: 2026-10-18T16:58:55.169725Z WARN tribuchet::worker: hub session ended: code: 'Unknown error', message: "h2 protocol error: error reading a body from connection", source: hyper::Error(Body, Error { kind: Io(Custom { kind: UnexpectedEof, error: "peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof" }) }) worker # [ 17.878065] tribuchet[899]: 2026-10-18T16:58:55.171694Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 28.517673] nix-daemon[1002]: reaped child process 1004, status = succeeded hub # [ 28.529637] tribuchet[1029]: 2026-10-18T16:58:55.454335Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 28.533386] tribuchet[1029]: 2026-10-18T16:58:55.454512Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 29.373644] tribuchet[1029]: 2026-10-18T16:58:56.298830Z INFO tribuchet::hub::submit: no capable worker yet; waiting system="x86_64-linux" hub # [ 29.511170] tribuchet[1029]: 2026-10-18T16:58:56.436288Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] hub # [ 29.521747] tribuchet[1029]: 2026-10-18T16:58:56.446514Z INFO tribuchet::hub::submit: queueing build id="f1db8b674c359434b0ced8f1f46bd257" system="x86_64-linux" worker # [ 18.928346] tribuchet[899]: 2026-10-18T16:58:56.221272Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 29.557642] tribuchet[1029]: 2026-10-18T16:58:56.481916Z INFO tribuchet::hub: dispatching build id="f1db8b674c359434b0ced8f1f46bd257" worker="worker" worker # [ 18.938321] tribuchet[899]: 2026-10-18T16:58:56.231961Z INFO tribuchet::worker::session: build assigned id="f1db8b674c359434b0ced8f1f46bd257" worker # [ 18.947120] nix-daemon[963]: accepted connection from pid 899, user tribuchet (trusted) hub # [ 29.585164] tribuchet[1029]: 2026-10-18T16:58:56.510222Z INFO tribuchet::hub::relay::staging: input path negotiation done id="f1db8b674c359434b0ced8f1f46bd257" total=7 missing=0 worker # [ 18.959579] tribuchet[899]: 2026-10-18T16:58:56.252678Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="f1db8b674c359434b0ced8f1f46bd257" fixed_output=false network=false net_isolation=false worker # [ 19.105813] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:58:56.398891Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 19.109774] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:58:56.403458Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 19.110913] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:58:56.403512Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 19.134825] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:58:56.427976Z INFO tribuchet::worker::agent: builder started id="f1db8b674c359434b0ced8f1f46bd257" pid=1038 worker # [ 19.135792] tribuchet[899]: 2026-10-18T16:58:56.428079Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="f1db8b674c359434b0ced8f1f46bd257" pid=1038 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/6cdc2c1fd0e91817/build worker # [ 19.698776] tribuchet[899]: 2026-10-18T16:58:56.991298Z INFO tribuchet::worker: handover requested; exiting hub # [ 30.328889] tribuchet[1029]: 2026-10-18T16:58:57.253824Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 30.333782] tribuchet[1029]: 2026-10-18T16:58:57.253900Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="f1db8b674c359434b0ced8f1f46bd257" worker # [ 19.740272] tribuchet[1065]: 2026-10-18T16:58:57.033731Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/etc/tribuchet/tls/ca.crt", cert: "/etc/tribuchet/tls/worker.crt", key: "/run/credentials/tribuchet-worker.service/worker-key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 1048576, sandbox_bin_sh: None, build_memory_max_bytes: Some(2147483648), max_jobs: 2, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {"aarch64-linux": "/nix/store/0ap7cqwsrl7k49pfbrx54v5x778g0rsv-qemu-user-static-x86_64-unknown-linux-musl-11.1.2/bin/qemu-aarch64"}, fod_network: NetPolicy { default: Allow, rules: [Rule { action: Deny, proto: Tcp, dst: Any, ports: [PortRange { start: 8766, end: 8766 }] }] }, recursive_nix: true, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 19.752192] tribuchet[1065]: 2026-10-18T16:58:57.034288Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 19.767435] tribuchet[1065]: 2026-10-18T16:58:57.059668Z INFO tribuchet::worker::resume: adopted running build id="f1db8b674c359434b0ced8f1f46bd257" pid=1038 worker # [ 19.776912] nix-daemon[963]: accepted connection from pid 1065, user tribuchet (trusted) worker # [ 19.845935] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1081]: 2026-10-18T16:58:57.139455Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 19.849313] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1081]: 2026-10-18T16:58:57.143046Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 19.852301] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1081]: 2026-10-18T16:58:57.146038Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 19.855114] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1081]: 2026-10-18T16:58:57.148853Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 19.864278] tribuchet[1065]: 2026-10-18T16:58:57.157087Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 30.488725] tribuchet[1029]: 2026-10-18T16:58:57.413768Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] hub # [ 30.494140] tribuchet[1029]: 2026-10-18T16:58:57.413851Z INFO tribuchet::hub: dispatching build id="f1db8b674c359434b0ced8f1f46bd257" worker="worker" worker # [ 19.868308] tribuchet[1065]: 2026-10-18T16:58:57.161940Z INFO tribuchet::worker::session: build resumed id="f1db8b674c359434b0ced8f1f46bd257" key="377d4f8123e740edf7f3cf41d5dfc19f2c9c5c20c7300c98c76280fabc29fab8" hub # [ 30.496421] tribuchet[1029]: 2026-10-18T16:58:57.419336Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="f1db8b674c359434b0ced8f1f46bd257" hub # [ 30.547109] tribuchet[1029]: 2026-10-18T16:58:57.472286Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 19.924713] tribuchet[1065]: 2026-10-18T16:58:57.217985Z WARN tribuchet::worker: hub session ended: code: 'Unknown error', message: "h2 protocol error: error reading a body from connection", source: hyper::Error(Body, Error { kind: Io(Custom { kind: UnexpectedEof, error: "peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof" }) }) worker # [ 19.931506] tribuchet[1065]: 2026-10-18T16:58:57.218093Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 30.577881] tribuchet[1090]: 2026-10-18T16:58:57.501988Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 30.579948] tribuchet[1090]: 2026-10-18T16:58:57.502161Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 31.558666] tribuchet[1090]: 2026-10-18T16:58:58.483480Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] worker # [ 20.975133] tribuchet[1065]: 2026-10-18T16:58:58.267587Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 32.552350] tribuchet[1090]: 2026-10-18T16:58:59.477074Z INFO tribuchet::hub::submit: queueing build id="a9a03b6eaa0a7633e62169c18d97e21e" system="x86_64-linux" hub # [ 32.554948] tribuchet[1090]: 2026-10-18T16:58:59.477129Z INFO tribuchet::hub: dispatching build id="a9a03b6eaa0a7633e62169c18d97e21e" worker="worker" worker # [ 21.927717] tribuchet[1065]: 2026-10-18T16:58:59.221295Z INFO tribuchet::worker::session: build resumed id="a9a03b6eaa0a7633e62169c18d97e21e" key="377d4f8123e740edf7f3cf41d5dfc19f2c9c5c20c7300c98c76280fabc29fab8" hub # [ 32.561471] tribuchet[1090]: 2026-10-18T16:58:59.486724Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="a9a03b6eaa0a7633e62169c18d97e21e" worker # [ 38.715818] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:59:16.008659Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=19580 cpu_usec=19217070 peak_memory_bytes=1011712 worker # [ 38.724201] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:59:16.008936Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 38.814934] tribuchet[1065]: 2026-10-18T16:59:16.107679Z INFO tribuchet::worker::build::agent_exec: builder finished id="f1db8b674c359434b0ced8f1f46bd257" exit_code=0 aborted=None worker # [ 38.846411] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1032]: 2026-10-18T16:59:16.140036Z INFO tribuchet::worker::agent: cleanup done id="f1db8b674c359434b0ced8f1f46bd257" worker # [ 38.962635] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1108]: 2026-10-18T16:59:16.256069Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 38.966208] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1108]: 2026-10-18T16:59:16.256970Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 38.968950] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1108]: 2026-10-18T16:59:16.257059Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 38.971630] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1108]: 2026-10-18T16:59:16.257169Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 38.977290] tribuchet[1065]: 2026-10-18T16:59:16.270982Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="a9a03b6eaa0a7633e62169c18d97e21e" hub # [ 49.605314] tribuchet[1090]: 2026-10-18T16:59:16.529795Z INFO tribuchet::hub::relay: build usage id="a9a03b6eaa0a7633e62169c18d97e21e" key="377d4f8123e740edf7f3cf41d5dfc19f2c9c5c20c7300c98c76280fabc29fab8" exit_code=0 wall_ms=19580 cpu_usec=19217070 peak_memory_bytes=1011712 oom_killed=false worker # [ 38.993149] tribuchet[1065]: 2026-10-18T16:59:16.286740Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="a9a03b6eaa0a7633e62169c18d97e21e" worker # [ 39.583975] systemd[1121]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 39.655974] systemd[1121]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 50.699512] tribuchet[1090]: 2026-10-18T16:59:17.624186Z INFO tribuchet::hub::submit: queueing build id="75af32cefdcea8ed258d14f910f7c078" system="x86_64-linux" hub # [ 50.702766] tribuchet[1090]: 2026-10-18T16:59:17.624243Z INFO tribuchet::hub: dispatching build id="75af32cefdcea8ed258d14f910f7c078" worker="worker" worker # [ 40.079343] tribuchet[1065]: 2026-10-18T16:59:17.371921Z INFO tribuchet::worker::session: build assigned id="75af32cefdcea8ed258d14f910f7c078" worker # [ 40.087805] nix-daemon[963]: accepted connection from pid 1065, user tribuchet (trusted) hub # [ 50.724409] tribuchet[1090]: 2026-10-18T16:59:17.649639Z INFO tribuchet::hub::relay::staging: input path negotiation done id="75af32cefdcea8ed258d14f910f7c078" total=7 missing=0 worker # [ 40.099166] tribuchet[1065]: 2026-10-18T16:59:17.392759Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="75af32cefdcea8ed258d14f910f7c078" fixed_output=false network=false net_isolation=false worker # [ 40.244703] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1144]: 2026-10-18T16:59:17.537643Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 40.251714] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1144]: 2026-10-18T16:59:17.545364Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 40.253189] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1144]: 2026-10-18T16:59:17.545444Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 40.284232] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1144]: 2026-10-18T16:59:17.577855Z INFO tribuchet::worker::agent: builder started id="75af32cefdcea8ed258d14f910f7c078" pid=1150 worker # [ 40.288568] tribuchet[1065]: 2026-10-18T16:59:17.581905Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="75af32cefdcea8ed258d14f910f7c078" pid=1150 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/9f042200054152dc/build [e2e] heartbeat t=30s worker # [ 59.714661] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1144]: 2026-10-18T16:59:37.007727Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=19429 cpu_usec=19103228 peak_memory_bytes=1011712 worker # [ 59.723190] tribuchet[1065]: 2026-10-18T16:59:37.015811Z INFO tribuchet::worker::build::agent_exec: builder finished id="75af32cefdcea8ed258d14f910f7c078" exit_code=0 aborted=None worker # [ 59.744705] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1144]: 2026-10-18T16:59:37.038397Z INFO tribuchet::worker::agent: cleanup done id="75af32cefdcea8ed258d14f910f7c078" worker # [ 59.856874] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1171]: 2026-10-18T16:59:37.150229Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 59.863203] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1171]: 2026-10-18T16:59:37.156905Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 59.863868] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1171]: 2026-10-18T16:59:37.156988Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 59.872666] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1171]: 2026-10-18T16:59:37.166368Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 59.952508] tribuchet[1065]: 2026-10-18T16:59:37.246101Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="75af32cefdcea8ed258d14f910f7c078" worker # [ 59.962594] tribuchet[1065]: 2026-10-18T16:59:37.256231Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="75af32cefdcea8ed258d14f910f7c078" hub # [ 70.587678] tribuchet[1090]: 2026-10-18T16:59:37.510046Z INFO tribuchet::hub::relay: build usage id="75af32cefdcea8ed258d14f910f7c078" key="824de5db982082488def6827fb432e0f66e5035702763a8071890117ca40e37e" exit_code=0 wall_ms=19429 cpu_usec=19103228 peak_memory_bytes=1011712 oom_killed=false worker # [ 60.319190] systemd[1183]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 60.408688] systemd[1183]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 71.431828] tribuchet[1090]: 2026-10-18T16:59:38.356802Z INFO tribuchet::hub::submit: queueing build id="52612bc13586daaba2719b1f935282dd" system="x86_64-linux" hub # [ 71.434906] tribuchet[1090]: 2026-10-18T16:59:38.356850Z INFO tribuchet::hub: dispatching build id="52612bc13586daaba2719b1f935282dd" worker="worker" worker # [ 60.808627] tribuchet[1065]: 2026-10-18T16:59:38.101286Z INFO tribuchet::worker::session: build assigned id="52612bc13586daaba2719b1f935282dd" worker # [ 60.816700] nix-daemon[963]: accepted connection from pid 1065, user tribuchet (trusted) hub # [ 71.455581] tribuchet[1090]: 2026-10-18T16:59:38.380767Z INFO tribuchet::hub::relay::staging: input path negotiation done id="52612bc13586daaba2719b1f935282dd" total=7 missing=0 worker # [ 60.827748] tribuchet[1065]: 2026-10-18T16:59:38.121427Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="52612bc13586daaba2719b1f935282dd" fixed_output=false network=false net_isolation=false worker # [ 60.919218] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:38.212291Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 60.919977] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:38.213568Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 60.920643] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:38.213603Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 60.928975] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:38.222704Z INFO tribuchet::worker::agent: builder started id="52612bc13586daaba2719b1f935282dd" pid=1228 worker # [ 60.929825] tribuchet[1065]: 2026-10-18T16:59:38.223411Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="52612bc13586daaba2719b1f935282dd" pid=1228 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/63bd09cc91fd5b0d/build worker # [ 61.023099] tribuchet[1065]: 2026-10-18T16:59:38.316822Z INFO tribuchet::worker: handover requested; exiting hub # [ 71.653776] tribuchet[1090]: 2026-10-18T16:59:38.577769Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 71.659191] tribuchet[1090]: 2026-10-18T16:59:38.577851Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="52612bc13586daaba2719b1f935282dd" worker # [ 61.058109] tribuchet[1242]: 2026-10-18T16:59:38.351529Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/etc/tribuchet/tls/ca.crt", cert: "/etc/tribuchet/tls/worker.crt", key: "/run/credentials/tribuchet-worker.service/worker-key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 1048576, sandbox_bin_sh: None, build_memory_max_bytes: Some(2147483648), max_jobs: 2, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {"aarch64-linux": "/nix/store/0ap7cqwsrl7k49pfbrx54v5x778g0rsv-qemu-user-static-x86_64-unknown-linux-musl-11.1.2/bin/qemu-aarch64"}, fod_network: NetPolicy { default: Allow, rules: [Rule { action: Deny, proto: Tcp, dst: Any, ports: [PortRange { start: 8766, end: 8766 }] }] }, recursive_nix: true, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 61.069811] tribuchet[1242]: 2026-10-18T16:59:38.363523Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 61.076146] tribuchet[1242]: 2026-10-18T16:59:38.369878Z INFO tribuchet::worker::resume: adopted running build id="52612bc13586daaba2719b1f935282dd" pid=1228 worker # [ 61.086064] nix-daemon[963]: accepted connection from pid 1242, user tribuchet (trusted) worker # [ 61.149423] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1258]: 2026-10-18T16:59:38.442934Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 61.152843] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1258]: 2026-10-18T16:59:38.446577Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 61.155963] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1258]: 2026-10-18T16:59:38.449701Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 61.158760] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1258]: 2026-10-18T16:59:38.452501Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 61.172740] tribuchet[1242]: 2026-10-18T16:59:38.466460Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 61.176158] tribuchet[1242]: 2026-10-18T16:59:38.469719Z INFO tribuchet::worker::session: build resumed id="52612bc13586daaba2719b1f935282dd" key="1ddf3bbc5a3d3cad8f2bffb2f1773743fa04b4ea844d1ed444c8a42aa9164681" hub # [ 71.799943] tribuchet[1090]: 2026-10-18T16:59:38.722833Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] hub # [ 71.814841] tribuchet[1090]: 2026-10-18T16:59:38.722978Z INFO tribuchet::hub: dispatching build id="52612bc13586daaba2719b1f935282dd" worker="worker" hub # [ 71.826576] tribuchet[1090]: 2026-10-18T16:59:38.747804Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="52612bc13586daaba2719b1f935282dd" [e2e] heartbeat t=60s worker # [ 75.920711] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:53.212506Z INFO tribuchet::worker::agent: builder exited code=137 wall_ms=14989 cpu_usec=14699096 peak_memory_bytes=21319680 worker # [ 75.928955] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:53.212688Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 76.131474] tribuchet[1242]: 2026-10-18T16:59:53.424140Z INFO tribuchet::worker::build::agent_exec: builder finished id="52612bc13586daaba2719b1f935282dd" exit_code=137 aborted=Some("build log exceeded the limit of 1048576 bytes") worker # [ 76.145976] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1215]: 2026-10-18T16:59:53.438663Z INFO tribuchet::worker::agent: cleanup done id="52612bc13586daaba2719b1f935282dd" worker # [ 76.297821] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1276]: 2026-10-18T16:59:53.589736Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 76.309662] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1276]: 2026-10-18T16:59:53.590061Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 76.310921] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1276]: 2026-10-18T16:59:53.590130Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 76.311695] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1276]: 2026-10-18T16:59:53.590248Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 76.395438] tribuchet[1242]: 2026-10-18T16:59:53.688969Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="52612bc13586daaba2719b1f935282dd" worker # [ 76.403297] tribuchet[1242]: 2026-10-18T16:59:53.696903Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="52612bc13586daaba2719b1f935282dd" hub # [ 87.025120] tribuchet[1090]: 2026-10-18T16:59:53.947497Z INFO tribuchet::hub::relay: build usage id="52612bc13586daaba2719b1f935282dd" key="1ddf3bbc5a3d3cad8f2bffb2f1773743fa04b4ea844d1ed444c8a42aa9164681" exit_code=1 wall_ms=14989 cpu_usec=14699096 peak_memory_bytes=21319680 oom_killed=false hub # [ 87.063542] systemd[1]: slowlogbuild.service: Main process exited, code=exited, status=100/n/a hub # [ 87.067737] systemd[1]: slowlogbuild.service: Failed with result 'exit-code'. worker # [ 77.056435] systemd[1288]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 77.124775] systemd[1288]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 88.163961] tribuchet[1090]: 2026-10-18T16:59:55.088737Z INFO tribuchet::hub::submit: queueing build id="c794268a22fd77139b0fd290a0fcf1ca" system="x86_64-linux" hub # [ 88.167096] tribuchet[1090]: 2026-10-18T16:59:55.088781Z INFO tribuchet::hub: dispatching build id="c794268a22fd77139b0fd290a0fcf1ca" worker="worker" worker # [ 77.539834] tribuchet[1242]: 2026-10-18T16:59:54.832530Z INFO tribuchet::worker::session: build assigned id="c794268a22fd77139b0fd290a0fcf1ca" worker # [ 77.551349] nix-daemon[963]: accepted connection from pid 1242, user tribuchet (trusted) worker # [ 77.563719] tribuchet[1242]: 2026-10-18T16:59:54.857057Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="c794268a22fd77139b0fd290a0fcf1ca" fixed_output=false network=false net_isolation=false hub # [ 88.197550] tribuchet[1090]: 2026-10-18T16:59:55.122785Z INFO tribuchet::hub::relay::staging: input path negotiation done id="c794268a22fd77139b0fd290a0fcf1ca" total=7 missing=0 worker # [ 77.654563] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T16:59:54.947821Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 77.657575] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T16:59:54.947962Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 77.660045] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T16:59:54.947992Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 77.662352] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T16:59:54.956001Z INFO tribuchet::worker::agent: builder started id="c794268a22fd77139b0fd290a0fcf1ca" pid=1345 worker # [ 77.670139] tribuchet[1242]: 2026-10-18T16:59:54.956067Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="c794268a22fd77139b0fd290a0fcf1ca" pid=1345 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/a599d4c6dfd02efd/build worker # [ 77.861278] tribuchet[1242]: 2026-10-18T16:59:55.154801Z INFO tribuchet::worker: handover requested; exiting hub # [ 88.491481] tribuchet[1090]: 2026-10-18T16:59:55.416038Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 88.496968] tribuchet[1090]: 2026-10-18T16:59:55.416125Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="c794268a22fd77139b0fd290a0fcf1ca" worker # [ 77.897941] tribuchet[1371]: 2026-10-18T16:59:55.191366Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/etc/tribuchet/tls/ca.crt", cert: "/etc/tribuchet/tls/worker.crt", key: "/run/credentials/tribuchet-worker.service/worker-key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 1048576, sandbox_bin_sh: None, build_memory_max_bytes: Some(2147483648), max_jobs: 3, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {"aarch64-linux": "/nix/store/0ap7cqwsrl7k49pfbrx54v5x778g0rsv-qemu-user-static-x86_64-unknown-linux-musl-11.1.2/bin/qemu-aarch64"}, fod_network: NetPolicy { default: Allow, rules: [Rule { action: Deny, proto: Tcp, dst: Any, ports: [PortRange { start: 8766, end: 8766 }] }] }, recursive_nix: true, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 77.909562] tribuchet[1371]: 2026-10-18T16:59:55.191747Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 77.913065] tribuchet[1371]: 2026-10-18T16:59:55.202948Z INFO tribuchet::worker::resume: adopted running build id="c794268a22fd77139b0fd290a0fcf1ca" pid=1345 worker # [ 77.917990] nix-daemon[963]: accepted connection from pid 1371, user tribuchet (trusted) worker # [ 77.985943] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1387]: 2026-10-18T16:59:55.279457Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 77.989442] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1387]: 2026-10-18T16:59:55.282999Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 77.992653] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1387]: 2026-10-18T16:59:55.283031Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 77.996354] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1387]: 2026-10-18T16:59:55.289138Z INFO tribuchet::worker::agent: no build held, exiting until the next activation hub # [ 88.634889] tribuchet[1090]: 2026-10-18T16:59:55.560067Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] worker # [ 78.019941] tribuchet[1371]: 2026-10-18T16:59:55.313441Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 78.023043] tribuchet[1371]: 2026-10-18T16:59:55.316641Z INFO tribuchet::worker::session: build resumed id="c794268a22fd77139b0fd290a0fcf1ca" key="1bc018cbea63450d03533651b04498d3acc9a44928352861cc3086b0a65980cb" hub # [ 88.646347] tribuchet[1090]: 2026-10-18T16:59:55.570007Z INFO tribuchet::hub: dispatching build id="c794268a22fd77139b0fd290a0fcf1ca" worker="worker" hub # [ 88.655398] tribuchet[1090]: 2026-10-18T16:59:55.579945Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="c794268a22fd77139b0fd290a0fcf1ca" worker # [ 91.712435] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T17:00:09.005387Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14049 cpu_usec=13777550 peak_memory_bytes=1044480 worker # [ 91.713962] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T17:00:09.005470Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 91.744606] tribuchet[1371]: 2026-10-18T17:00:09.037971Z INFO tribuchet::worker::build::agent_exec: builder finished id="c794268a22fd77139b0fd290a0fcf1ca" exit_code=0 aborted=None worker # [ 91.757768] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1334]: 2026-10-18T17:00:09.051460Z INFO tribuchet::worker::agent: cleanup done id="c794268a22fd77139b0fd290a0fcf1ca" worker # [ 91.893707] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1407]: 2026-10-18T17:00:09.184875Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 91.899539] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1407]: 2026-10-18T17:00:09.185131Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 91.904460] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1407]: 2026-10-18T17:00:09.185209Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 91.908691] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1407]: 2026-10-18T17:00:09.185306Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 91.952708] tribuchet[1371]: 2026-10-18T17:00:09.246311Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="c794268a22fd77139b0fd290a0fcf1ca" hub # [ 102.580129] tribuchet[1090]: 2026-10-18T17:00:09.504581Z INFO tribuchet::hub::relay: build usage id="c794268a22fd77139b0fd290a0fcf1ca" key="1bc018cbea63450d03533651b04498d3acc9a44928352861cc3086b0a65980cb" exit_code=0 wall_ms=14049 cpu_usec=13777550 peak_memory_bytes=1044480 oom_killed=false worker # [ 91.968297] tribuchet[1371]: 2026-10-18T17:00:09.261865Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="c794268a22fd77139b0fd290a0fcf1ca" worker # [ 92.581970] systemd[1419]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 92.674774] systemd[1419]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 104.096717] tribuchet[1090]: 2026-10-18T17:00:11.021754Z INFO tribuchet::hub::submit: queueing build id="2559865713c09d9962a914260a86c277" system="x86_64-linux" hub # [ 104.099617] tribuchet[1090]: 2026-10-18T17:00:11.024506Z INFO tribuchet::hub: dispatching build id="2559865713c09d9962a914260a86c277" worker="worker" worker # [ 93.477703] tribuchet[1371]: 2026-10-18T17:00:10.769963Z INFO tribuchet::worker::session: build assigned id="2559865713c09d9962a914260a86c277" worker # [ 93.488672] nix-daemon[963]: accepted connection from pid 1371, user tribuchet (trusted) hub # [ 104.129164] tribuchet[1090]: 2026-10-18T17:00:11.054349Z INFO tribuchet::hub::relay::staging: input path negotiation done id="2559865713c09d9962a914260a86c277" total=7 missing=0 worker # [ 93.503499] tribuchet[1371]: 2026-10-18T17:00:10.796899Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="2559865713c09d9962a914260a86c277" fixed_output=false network=false net_isolation=false worker # [ 93.593232] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1465]: 2026-10-18T17:00:10.886654Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 93.598401] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1465]: 2026-10-18T17:00:10.888848Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 93.601282] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1465]: 2026-10-18T17:00:10.888879Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 93.605088] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1465]: 2026-10-18T17:00:10.897939Z INFO tribuchet::worker::agent: builder started id="2559865713c09d9962a914260a86c277" pid=1473 worker # [ 93.607893] tribuchet[1371]: 2026-10-18T17:00:10.897996Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="2559865713c09d9962a914260a86c277" pid=1473 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/720ad3eed5d16a6a/build hub # [ 105.082968] systemd[1]: cancelbuild.service: Main process exited, code=killed, status=9/KILL hub # [ 105.084545] systemd[1]: cancelbuild.service: Failed with result 'signal'. [e2e] heartbeat t=90s worker # [ 105.477076] tribuchet[1371]: 2026-10-18T17:00:22.769848Z INFO tribuchet::worker::session: hub cancelled the build id="2559865713c09d9962a914260a86c277" hub # [ 116.101649] tribuchet[1090]: 2026-10-18T17:00:23.025744Z INFO tribuchet::hub::relay: no attach client left; cancelling build id="2559865713c09d9962a914260a86c277" worker # [ 105.627774] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1465]: 2026-10-18T17:00:22.920807Z INFO tribuchet::worker::agent: builder exited code=137 wall_ms=12022 cpu_usec=11757693 peak_memory_bytes=1536000 worker # [ 105.834486] tribuchet[1371]: 2026-10-18T17:00:23.127864Z INFO tribuchet::worker::build::agent_exec: builder finished id="2559865713c09d9962a914260a86c277" exit_code=137 aborted=Some("build cancelled") worker # [ 105.849834] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1465]: 2026-10-18T17:00:23.143487Z INFO tribuchet::worker::agent: cleanup done id="2559865713c09d9962a914260a86c277" worker # [ 105.966119] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1687]: 2026-10-18T17:00:23.259536Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 105.966805] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1687]: 2026-10-18T17:00:23.260463Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 105.967348] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1687]: 2026-10-18T17:00:23.260513Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 105.973469] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1687]: 2026-10-18T17:00:23.261574Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 106.042340] tribuchet[1371]: 2026-10-18T17:00:23.336007Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="2559865713c09d9962a914260a86c277" worker # [ 106.048289] tribuchet[1371]: 2026-10-18T17:00:23.341933Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="2559865713c09d9962a914260a86c277" hub # [ 116.671167] tribuchet[1090]: 2026-10-18T17:00:23.595967Z INFO tribuchet::hub::relay: build usage id="2559865713c09d9962a914260a86c277" key="7202846d83769dd6e209fd70f1664e0b721c99e399e3921dda2d161801db64e2" exit_code=1 wall_ms=12022 cpu_usec=11757693 peak_memory_bytes=1536000 oom_killed=false hub # [ 116.899168] systemd[2001]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 116.981681] systemd[2001]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 117.262415] tribuchet[1090]: 2026-10-18T17:00:24.186830Z INFO tribuchet::hub::submit: queueing build id="f637a6ba940c392d2473ff528229b9d5" system="x86_64-linux" hub # [ 117.265141] tribuchet[1090]: 2026-10-18T17:00:24.186878Z INFO tribuchet::hub: dispatching build id="f637a6ba940c392d2473ff528229b9d5" worker="worker" worker # [ 106.638148] tribuchet[1371]: 2026-10-18T17:00:23.930971Z INFO tribuchet::worker::session: build assigned id="f637a6ba940c392d2473ff528229b9d5" worker # [ 106.648188] nix-daemon[963]: accepted connection from pid 1371, user tribuchet (trusted) hub # [ 117.284107] tribuchet[1090]: 2026-10-18T17:00:24.209248Z INFO tribuchet::hub::relay::staging: input path negotiation done id="f637a6ba940c392d2473ff528229b9d5" total=7 missing=0 worker # [ 106.658831] tribuchet[1371]: 2026-10-18T17:00:23.952114Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="f637a6ba940c392d2473ff528229b9d5" fixed_output=false network=false net_isolation=false worker # [ 106.819684] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1705]: 2026-10-18T17:00:24.112715Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 106.826468] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1705]: 2026-10-18T17:00:24.120134Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 106.828176] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1705]: 2026-10-18T17:00:24.120236Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 106.858950] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1705]: 2026-10-18T17:00:24.152589Z INFO tribuchet::worker::agent: builder started id="f637a6ba940c392d2473ff528229b9d5" pid=1711 worker # [ 106.862645] tribuchet[1371]: 2026-10-18T17:00:24.155871Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="f637a6ba940c392d2473ff528229b9d5" pid=1711 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/5d61a5e08373cce7/build [e2e] heartbeat t=120s worker # [ 136.714324] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1705]: 2026-10-18T17:00:54.007426Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=29854 cpu_usec=29371809 peak_memory_bytes=1007616 worker # [ 136.910495] tribuchet[1371]: 2026-10-18T17:00:54.203667Z INFO tribuchet::worker::build::agent_exec: builder finished id="f637a6ba940c392d2473ff528229b9d5" exit_code=0 aborted=None worker # [ 136.940429] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1705]: 2026-10-18T17:00:54.234003Z INFO tribuchet::worker::agent: cleanup done id="f637a6ba940c392d2473ff528229b9d5" worker # [ 137.087741] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1730]: 2026-10-18T17:00:54.380640Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 137.093374] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1730]: 2026-10-18T17:00:54.387032Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 137.095052] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1730]: 2026-10-18T17:00:54.387095Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 137.096251] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1730]: 2026-10-18T17:00:54.387195Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 137.169454] tribuchet[1371]: 2026-10-18T17:00:54.463035Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="f637a6ba940c392d2473ff528229b9d5" hub # [ 147.797149] tribuchet[1090]: 2026-10-18T17:00:54.721115Z INFO tribuchet::hub::relay: build usage id="f637a6ba940c392d2473ff528229b9d5" key="7202846d83769dd6e209fd70f1664e0b721c99e399e3921dda2d161801db64e2" exit_code=0 wall_ms=29854 cpu_usec=29371809 peak_memory_bytes=1007616 oom_killed=false worker # [ 137.184295] tribuchet[1371]: 2026-10-18T17:00:54.477938Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="f637a6ba940c392d2473ff528229b9d5" hub # [ 148.307483] tribuchet[1090]: 2026-10-18T17:00:55.232414Z INFO tribuchet::hub::submit: queueing build id="5e5f661549972521b615099f3f3d77b8" system="x86_64-linux" hub # [ 148.310545] tribuchet[1090]: 2026-10-18T17:00:55.235199Z INFO tribuchet::hub: dispatching build id="5e5f661549972521b615099f3f3d77b8" worker="worker" worker # [ 137.685786] tribuchet[1371]: 2026-10-18T17:00:54.979369Z INFO tribuchet::worker::session: build assigned id="5e5f661549972521b615099f3f3d77b8" worker # [ 137.694331] nix-daemon[963]: accepted connection from pid 1371, user tribuchet (trusted) hub # [ 148.326132] tribuchet[1090]: 2026-10-18T17:00:55.251031Z INFO tribuchet::hub::submit: queueing build id="7dc9b040940d6ddab53c0efe9b571da9" system="x86_64-linux" hub # [ 148.328551] tribuchet[1090]: 2026-10-18T17:00:55.251068Z INFO tribuchet::hub: dispatching build id="7dc9b040940d6ddab53c0efe9b571da9" worker="worker" hub # [ 148.331033] tribuchet[1090]: 2026-10-18T17:00:55.256262Z INFO tribuchet::hub::relay::staging: input path negotiation done id="5e5f661549972521b615099f3f3d77b8" total=7 missing=0 worker # [ 137.704841] tribuchet[1371]: 2026-10-18T17:00:54.998238Z INFO tribuchet::worker::session: build assigned id="7dc9b040940d6ddab53c0efe9b571da9" worker # [ 137.706244] tribuchet[1371]: 2026-10-18T17:00:54.998456Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="5e5f661549972521b615099f3f3d77b8" fixed_output=false network=false net_isolation=false worker # [ 137.723781] nix-daemon[963]: accepted connection from pid 1371, user tribuchet (trusted) hub # [ 148.362343] tribuchet[1090]: 2026-10-18T17:00:55.287567Z INFO tribuchet::hub::relay::staging: input path negotiation done id="7dc9b040940d6ddab53c0efe9b571da9" total=7 missing=0 worker # [ 137.737620] tribuchet[1371]: 2026-10-18T17:00:55.031265Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="7dc9b040940d6ddab53c0efe9b571da9" fixed_output=false network=false net_isolation=false worker # [ 137.833523] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1746]: 2026-10-18T17:00:55.126911Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 137.835241] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1746]: 2026-10-18T17:00:55.128843Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 137.835792] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1746]: 2026-10-18T17:00:55.128877Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 137.847553] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1748]: 2026-10-18T17:00:55.141082Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 137.849237] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1748]: 2026-10-18T17:00:55.142853Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 137.849915] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1748]: 2026-10-18T17:00:55.142884Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 137.855290] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1746]: 2026-10-18T17:00:55.149010Z INFO tribuchet::worker::agent: builder started id="7dc9b040940d6ddab53c0efe9b571da9" pid=1756 worker # [ 137.856225] tribuchet[1371]: 2026-10-18T17:00:55.149758Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="7dc9b040940d6ddab53c0efe9b571da9" pid=1756 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/1415eba9e7d0a352/build worker # [ 137.868485] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1748]: 2026-10-18T17:00:55.162211Z INFO tribuchet::worker::agent: builder started id="5e5f661549972521b615099f3f3d77b8" pid=1764 worker # [ 137.871051] tribuchet[1371]: 2026-10-18T17:00:55.162928Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="5e5f661549972521b615099f3f3d77b8" pid=1764 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/81f7bc9e3553a8b6/build worker # [ 152.711765] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1748]: 2026-10-18T17:01:10.004674Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14842 cpu_usec=14589685 peak_memory_bytes=1007616 worker # [ 152.715617] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1746]: 2026-10-18T17:01:10.004885Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14855 cpu_usec=14588260 peak_memory_bytes=1519616 worker # [ 152.866351] tribuchet[1371]: 2026-10-18T17:01:10.159464Z INFO tribuchet::worker::build::agent_exec: builder finished id="7dc9b040940d6ddab53c0efe9b571da9" exit_code=0 aborted=None worker # [ 152.877276] tribuchet[1371]: 2026-10-18T17:01:10.170877Z INFO tribuchet::worker::build::agent_exec: builder finished id="5e5f661549972521b615099f3f3d77b8" exit_code=0 aborted=None worker # [ 152.889890] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1746]: 2026-10-18T17:01:10.183565Z INFO tribuchet::worker::agent: cleanup done id="7dc9b040940d6ddab53c0efe9b571da9" worker # [ 152.896159] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1748]: 2026-10-18T17:01:10.185417Z INFO tribuchet::worker::agent: cleanup done id="5e5f661549972521b615099f3f3d77b8" worker # [ 152.978419] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1788]: 2026-10-18T17:01:10.271487Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 152.981768] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1788]: 2026-10-18T17:01:10.271585Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 152.984606] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1788]: 2026-10-18T17:01:10.271612Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 152.987031] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1788]: 2026-10-18T17:01:10.271699Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 152.997220] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1790]: 2026-10-18T17:01:10.290647Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 153.000187] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1790]: 2026-10-18T17:01:10.292841Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 153.002975] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1790]: 2026-10-18T17:01:10.292870Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 153.005404] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1790]: 2026-10-18T17:01:10.292949Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 153.072140] tribuchet[1371]: 2026-10-18T17:01:10.365814Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="7dc9b040940d6ddab53c0efe9b571da9" hub # [ 163.701721] tribuchet[1090]: 2026-10-18T17:01:10.625304Z INFO tribuchet::hub::relay: build usage id="7dc9b040940d6ddab53c0efe9b571da9" key="65d6dba4a04f141b705645a704627ef88f462a57625ba3a616899b55ef38dc6b" exit_code=0 wall_ms=14855 cpu_usec=14588260 peak_memory_bytes=1519616 oom_killed=false worker # [ 153.089681] tribuchet[1371]: 2026-10-18T17:01:10.383297Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="7dc9b040940d6ddab53c0efe9b571da9" worker # [ 153.094623] tribuchet[1371]: 2026-10-18T17:01:10.383511Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="5e5f661549972521b615099f3f3d77b8" hub # [ 163.716533] tribuchet[1090]: 2026-10-18T17:01:10.641585Z INFO tribuchet::hub::relay: build usage id="5e5f661549972521b615099f3f3d77b8" key="3faad6839cbdb782b8c57e8dad333ceb25ce3ce163250712cdec6f997a6bd047" exit_code=0 wall_ms=14842 cpu_usec=14589685 peak_memory_bytes=1007616 oom_killed=false worker # [ 153.104553] tribuchet[1371]: 2026-10-18T17:01:10.398237Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="5e5f661549972521b615099f3f3d77b8" worker # [ 153.425844] systemd[1805]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 153.515935] systemd[1805]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 164.689536] tribuchet[1090]: 2026-10-18T17:01:11.614810Z INFO tribuchet::hub::submit: queueing build id="df04c3669ea1755c062d801e38ea7844" system="x86_64-linux" hub # [ 164.692549] tribuchet[1090]: 2026-10-18T17:01:11.617620Z INFO tribuchet::hub: dispatching build id="df04c3669ea1755c062d801e38ea7844" worker="worker" worker # [ 154.068870] tribuchet[1371]: 2026-10-18T17:01:11.361519Z INFO tribuchet::worker::session: build assigned id="df04c3669ea1755c062d801e38ea7844" worker # [ 154.081749] nix-daemon[963]: accepted connection from pid 1371, user tribuchet (trusted) hub # [ 164.720493] tribuchet[1090]: 2026-10-18T17:01:11.645309Z INFO tribuchet::hub::relay::staging: input path negotiation done id="df04c3669ea1755c062d801e38ea7844" total=7 missing=0 worker # [ 154.094697] tribuchet[1371]: 2026-10-18T17:01:11.388328Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="df04c3669ea1755c062d801e38ea7844" fixed_output=false network=false net_isolation=false worker # [ 154.204218] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:11.497703Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 154.207504] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:11.501166Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 154.208140] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:11.501205Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 154.225063] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:11.518542Z INFO tribuchet::worker::agent: builder started id="df04c3669ea1755c062d801e38ea7844" pid=1858 worker # [ 154.225686] tribuchet[1371]: 2026-10-18T17:01:11.518601Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="df04c3669ea1755c062d801e38ea7844" pid=1858 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/b45d55b1545c8b25/build worker # [ 155.000059] tribuchet[1371]: 2026-10-18T17:01:12.293152Z INFO tribuchet::worker: handover requested; exiting hub # [ 165.630171] tribuchet[1090]: 2026-10-18T17:01:12.554996Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 165.635164] tribuchet[1090]: 2026-10-18T17:01:12.555087Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="df04c3669ea1755c062d801e38ea7844" hub # [ 168.632552] tribuchet[1090]: 2026-10-18T17:01:15.556803Z WARN tribuchet::hub::state: failing queued build: last capable worker left id="df04c3669ea1755c062d801e38ea7844" hub # [ 169.839616] tribuchet[1090]: 2026-10-18T17:01:16.764624Z INFO tribuchet::hub::submit: no capable worker; declining system="x86_64-linux" worker # [ 159.679107] tribuchet[1902]: 2026-10-18T17:01:16.972549Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/etc/tribuchet/tls/ca.crt", cert: "/etc/tribuchet/tls/worker.crt", key: "/run/credentials/tribuchet-worker.service/worker-key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 1048576, sandbox_bin_sh: None, build_memory_max_bytes: Some(2147483648), max_jobs: 3, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {"aarch64-linux": "/nix/store/0ap7cqwsrl7k49pfbrx54v5x778g0rsv-qemu-user-static-x86_64-unknown-linux-musl-11.1.2/bin/qemu-aarch64"}, fod_network: NetPolicy { default: Allow, rules: [Rule { action: Deny, proto: Tcp, dst: Any, ports: [PortRange { start: 8766, end: 8766 }] }] }, recursive_nix: true, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 159.690736] tribuchet[1902]: 2026-10-18T17:01:16.984458Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 159.696489] tribuchet[1902]: 2026-10-18T17:01:16.990206Z INFO tribuchet::worker::resume: adopted running build id="df04c3669ea1755c062d801e38ea7844" pid=1858 worker # [ 159.707280] nix-daemon[963]: accepted connection from pid 1902, user tribuchet (trusted) worker # [ 159.773987] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1918]: 2026-10-18T17:01:17.067452Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 159.774563] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1918]: 2026-10-18T17:01:17.067548Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 159.775146] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1918]: 2026-10-18T17:01:17.067576Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 159.781839] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1918]: 2026-10-18T17:01:17.073844Z INFO tribuchet::worker::agent: no build held, exiting until the next activation hub # [ 170.417409] tribuchet[1090]: 2026-10-18T17:01:17.342512Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] worker # [ 159.831852] tribuchet[1902]: 2026-10-18T17:01:17.125533Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 170.775109] tribuchet[1090]: 2026-10-18T17:01:17.700265Z INFO tribuchet::hub::submit: queueing build id="6d729f1ff864a31313bf9a9df5670b3d" system="x86_64-linux" hub # [ 170.777753] tribuchet[1090]: 2026-10-18T17:01:17.700307Z INFO tribuchet::hub: dispatching build id="6d729f1ff864a31313bf9a9df5670b3d" worker="worker" worker # [ 160.153319] tribuchet[1902]: 2026-10-18T17:01:17.446913Z INFO tribuchet::worker::session: build resumed id="6d729f1ff864a31313bf9a9df5670b3d" key="859fc8104e9cc1b1caca96546ba777664f0b001397e68c3f47a0c522d90b22dd" hub # [ 170.787353] tribuchet[1090]: 2026-10-18T17:01:17.712604Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="6d729f1ff864a31313bf9a9df5670b3d" [e2e] heartbeat t=150s worker # [ 183.712524] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:41.005366Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=29486 cpu_usec=28965994 peak_memory_bytes=1044480 worker # [ 183.714080] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:41.005513Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 183.751854] tribuchet[1902]: 2026-10-18T17:01:41.045195Z INFO tribuchet::worker::build::agent_exec: builder finished id="df04c3669ea1755c062d801e38ea7844" exit_code=0 aborted=None worker # [ 183.771761] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1850]: 2026-10-18T17:01:41.065452Z INFO tribuchet::worker::agent: cleanup done id="df04c3669ea1755c062d801e38ea7844" worker # [ 183.880401] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1938]: 2026-10-18T17:01:41.173447Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 183.887529] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1938]: 2026-10-18T17:01:41.181191Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 183.888653] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1938]: 2026-10-18T17:01:41.181273Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 183.898155] n27pvxz62bpg6syybl076pq7bf1dddmq-tribuchet-agent[1938]: 2026-10-18T17:01:41.191766Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 183.925961] tribuchet[1902]: 2026-10-18T17:01:41.219511Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="6d729f1ff864a31313bf9a9df5670b3d" hub # [ 194.553102] tribuchet[1090]: 2026-10-18T17:01:41.477377Z INFO tribuchet::hub::relay: build usage id="6d729f1ff864a31313bf9a9df5670b3d" key="859fc8104e9cc1b1caca96546ba777664f0b001397e68c3f47a0c522d90b22dd" exit_code=0 wall_ms=29486 cpu_usec=28965994 peak_memory_bytes=1044480 oom_killed=false worker # [ 183.940212] tribuchet[1902]: 2026-10-18T17:01:41.233866Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="6d729f1ff864a31313bf9a9df5670b3d" worker # [ 184.507677] systemd[1950]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 184.579971] systemd[1950]: Failed to adjust io pressure threshold, ignoring: Device or resource busy ok test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 19 filtered out; finished in 170.25s (finished: subtest: daemon lifecycle, in 170.28 seconds) (finished: run the VM test script, in 197.12 seconds) test script finished in 197.21s cleanup kill QemuMachine (pid 54) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) hub # [2026-10-18T17:01:43Z INFO virtiofsd] Client disconnected, shutting down hub # [2026-10-18T17:01:43Z INFO virtiofsd] Client disconnected, shutting down hub # [2026-10-18T17:01:43Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 55) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) worker # [2026-10-18T17:01:44Z INFO virtiofsd] Client disconnected, shutting down worker # [2026-10-18T17:01:44Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.49 seconds) SSH backdoor enabled, the machines can be accessed like this: Note: this requires systemd-ssh-proxy(1) to be enabled (default on NixOS 25.05 and newer). hub: ssh -o User=root vsock-mux//build/tmph1cv_o5t/hub_host.socket worker: ssh -o User=root vsock-mux//build/tmph1cv_o5t/worker_host.socket additionally exposed symbols: hub, worker, 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