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.01 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 # Disk image does not exist, creating the virtualisation disk image... hub: QEMU running (pid 55) hub # Formatting '/build/vm-state-hub/tmp.wGXo7ySW7Z', 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: 0584c315-6152-4e74-972a-fe57a4e4bca7 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-11-13T13:23:13Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-11-13T13:23:13Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-11-13T13:23:13Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-11-13T13:23:13Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-11-13T13:23:13Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-11-13T13:23:13Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-11-13T13:23:13Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-11-13T13:23:13Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-11-13T13:23:13Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-11-13T13:23:13Z INFO virtiofsd] Client connected, servicing requests hub # [2026-11-13T13:23:13Z INFO virtiofsd] Client connected, servicing requests hub # [2026-11-13T13:23:13Z 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)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026 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/rl1kc8z0pmbq1whdp4bd9nw25x3d5qrd-nixos-system-hub-test/init regInfo=/nix/.ro-store/yili6b4p6ylgc045ndiwyj1ynl6g7gbb-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.000001] kvm-clock: using sched offset of 519432013 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000006] tsc: Detected 2400.012 MHz processor hub # [ 0.000827] last_pfn = 0x180000 max_arch_pfn = 0x10000000000 hub # [ 0.000877] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000882] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.000940] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 hub # [ 0.002852] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.002866] Using GB pages for direct mapping hub # [ 0.002978] RAMDISK: [mem 0x7e2e6000-0x7ffcffff] hub # [ 0.002987] ACPI: Early table checksum verification disabled hub # [ 0.002991] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) hub # [ 0.002995] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003000] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003008] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003010] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.003011] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003013] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003015] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003016] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003018] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] hub # [ 0.003019] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] hub # [ 0.003019] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.003020] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] hub # [ 0.003020] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] hub # [ 0.003021] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] hub # [ 0.003022] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] hub # [ 0.003296] No NUMA configuration found hub # [ 0.003297] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] hub # [ 0.003300] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff] hub # [ 0.005885] Zone ranges: hub # [ 0.005886] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005888] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] hub # [ 0.005889] Normal [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005891] Device empty hub # [ 0.005892] Movable zone start for each node hub # [ 0.005893] Early memory node ranges hub # [ 0.005893] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005895] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.005896] node 0: [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005897] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] hub # [ 0.005921] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006206] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.086542] On node 0, zone Normal: 40 pages in unavailable ranges hub # [ 0.087049] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.087064] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.087096] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.087099] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.087101] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.087103] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.087104] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.087105] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.087107] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.087108] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.087114] TSC deadline timer available hub # [ 0.087119] CPU topo: Max. logical packages: 1 hub # [ 0.087120] CPU topo: Max. logical dies: 1 hub # [ 0.087120] CPU topo: Max. dies per package: 1 hub # [ 0.087123] CPU topo: Max. threads per core: 1 hub # [ 0.087124] CPU topo: Num. cores per package: 1 hub # [ 0.087124] CPU topo: Num. threads per package: 1 hub # [ 0.087125] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.087150] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.087180] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.087182] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.087183] PM: hibernation: Registered nosave memory: [mem 0x7ffd8000-0xffffffff] hub # [ 0.087184] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.087186] Booting paravirtualized kernel on KVM hub # [ 0.087190] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.091851] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.094139] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.094184] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.094186] 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/rl1kc8z0pmbq1whdp4bd9nw25x3d5qrd-nixos-system-hub-test/init regInfo=/nix/.ro-store/yili6b4p6ylgc045ndiwyj1ynl6g7gbb-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.094294] Unknown kernel command line parameters "regInfo=/nix/.ro-store/yili6b4p6ylgc045ndiwyj1ynl6g7gbb-closure-info/registration", will be passed to user space. hub # [ 0.094307] random: crng init done hub # [ 0.094308] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.099029] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) hub # [ 0.101257] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.101292] software IO TLB: area num 1. hub # [ 0.180103] Fallback order for Node 0: 0 hub # [ 0.180111] Built 1 zonelists, mobility grouping on. Total pages: 1048438 hub # [ 0.180113] Policy zone: Normal hub # [ 0.183207] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.191038] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.200850] allocated 8388608 bytes of page_ext hub # [ 0.211560] ftrace: allocating 48837 entries in 192 pages hub # [ 0.211562] ftrace: allocated 192 pages with 2 groups hub # [ 0.212472] Dynamic Preempt: lazy hub # [ 0.212627] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.212628] rcu: RCU event tracing is enabled. hub # [ 0.212629] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.212630] Trampoline variant of Tasks RCU enabled. hub # [ 0.212631] Rude variant of Tasks RCU enabled. hub # [ 0.212631] Tracing variant of Tasks RCU enabled. hub # [ 0.212632] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.212633] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.212646] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.212649] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.212651] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.217121] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.217473] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.217483] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.217605] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.221171] Console: colour VGA+ 80x25 hub # [ 0.221174] printk: legacy console [tty0] enabled hub # [ 0.252051] printk: legacy console [ttyS0] enabled hub # [ 0.360640] ACPI: Core revision 20250807 hub # [ 0.361551] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.363222] APIC: Switch to symmetric I/O mode setup hub # [ 0.364258] x2apic enabled hub # [ 0.365097] APIC: Switched APIC routing to: physical x2apic hub # [ 0.367319] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.368518] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns hub # [ 0.370457] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) hub # [ 0.371560] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.373631] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.374455] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.375468] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.376455] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.378455] Transient Scheduler Attacks: Vulnerable: No microcode hub # [ 0.379454] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.381196] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.382246] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.383464] Spectre V2 : Enabling IBPB for BPF hub # [ 0.384456] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.385455] active return thunk: srso_alias_return_thunk hub # [ 0.386475] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.387454] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.389275] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.390266] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.391454] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.392454] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.393455] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.394457] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.395455] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.397247] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.398273] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.399311] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.400454] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. hub # [ 0.435845] Freeing SMP alternatives memory: 48K hub # [ 0.436457] pid_max: default: 32768 minimum: 301 hub # [ 0.437551] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.438570] landlock: Up and running. hub # [ 0.439454] Yama: becoming mindful. hub # [ 0.440286] LSM support for eBPF active hub # [ 0.441115] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.442520] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.444936] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.446078] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.446463] ... version: 2 hub # [ 0.447221] ... bit width: 48 hub # [ 0.447456] ... generic counters: 6 hub # [ 0.448218] ... generic bitmap: 000000000000003f hub # [ 0.448456] ... fixed-purpose counters: 0 hub # [ 0.449188] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.449456] ... value mask: 0000ffffffffffff hub # [ 0.450374] ... max period: 00007fffffffffff hub # [ 0.451198] ... global_ctrl mask: 000000000000003f hub # [ 0.451560] signal: max sigframe size: 3376 hub # [ 0.452439] rcu: Hierarchical SRCU implementation. hub # [ 0.453103] rcu: Max phase no-delay instances is 400. hub # [ 0.458110] smp: Bringing up secondary CPUs ... hub # [ 0.458470] smp: Brought up 1 node, 1 CPU hub # [ 0.459199] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) hub # [ 0.459669] Memory: 3959904K/4193752K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 220196K reserved, 0K cma-reserved) hub # [ 0.460865] devtmpfs: initialized hub # [ 0.461632] x86/mm: Memory block size: 128MB hub # [ 0.463955] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.464488] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.465532] pinctrl core: initialized pinctrl subsystem hub # [ 0.466744] PM: RTC time: 13:23:14, date: 2026-11-13 hub # [ 0.470724] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.472314] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.473437] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.475067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.475466] audit: initializing netlink subsys (disabled) hub # [ 0.476633] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.476635] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.477461] audit: type=2000 audit(1794576193.960:1): state=initialized audit_enabled=0 res=1 hub # [ 0.479458] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.479459] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.480432] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.481241] cpuidle: using governor menu hub # [ 0.483575] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.484702] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.485459] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.486470] PCI: Using configuration type 1 for base access hub # [ 0.487655] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.492569] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.493458] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.498457] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.499456] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.509820] ACPI: Added _OSI(Module Device) hub # [ 0.510458] ACPI: Added _OSI(Processor Device) hub # [ 0.511253] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.520706] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.524870] ACPI: Interpreter enabled hub # [ 0.525472] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.526229] ACPI: Using IOAPIC for interrupt routing hub # [ 0.528513] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.529457] PCI: Using E820 reservations for host bridge windows hub # [ 0.532603] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.538936] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.539463] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.540535] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.541582] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.543166] PCI host bridge to bus 0000:00 hub # [ 0.543462] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.544456] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.545456] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.546456] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.547456] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.548457] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.549457] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.550512] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.551950] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.554549] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.555468] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.556478] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.557799] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.559201] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.562465] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] hub # [ 0.564168] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.564478] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] hub # [ 0.565462] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.567032] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.569499] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.570405] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.571515] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] hub # [ 0.573030] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.575500] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.576416] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.577272] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] hub # [ 0.579028] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.582434] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.583179] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.583478] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] hub # [ 0.584462] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.586030] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.588503] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.589479] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] hub # [ 0.591039] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.592505] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.593478] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] hub # [ 0.595041] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.596469] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.597449] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] hub # [ 0.599013] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.600504] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.601484] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] hub # [ 0.603944] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.606457] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.607328] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.608261] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] hub # [ 0.610039] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.612741] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.613463] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.614478] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] hub # [ 0.616048] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.617504] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.618479] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 0.620018] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.621266] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] hub # [ 0.622355] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.624360] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] hub # [ 0.625359] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.627484] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] hub # [ 0.628664] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.631307] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.632505] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.633777] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.634712] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.636524] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] hub # [ 0.637464] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] hub # [ 0.638777] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.640330] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.644553] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.645561] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.646563] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.647555] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.648552] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.649555] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.650573] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.651554] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.652503] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.653472] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.654533] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.655555] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.656474] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.657472] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.658470] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.659468] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.661486] iommu: Default domain type: Translated hub # [ 0.662305] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.663551] ACPI: bus type USB registered hub # [ 0.664317] usbcore: registered new interface driver usbfs hub # [ 0.665307] usbcore: registered new interface driver hub hub # [ 0.666194] usbcore: registered new device driver usb hub # [ 0.667407] NetLabel: Initializing hub # [ 0.667939] NetLabel: domain hash size = 128 hub # [ 0.668456] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.669464] NetLabel: unlabeled traffic allowed by default hub # [ 0.670418] PCI: Using ACPI for IRQ routing hub # [ 0.714278] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 0.714452] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 0.714452] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.714461] vgaarb: loaded hub # [ 0.715307] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.716136] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.719577] clocksource: Switched to clocksource kvm-clock hub # [ 0.723939] VFS: Disk quotas dquot_6.6.0 hub # [ 0.724680] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.726091] pnp: PnP ACPI init hub # [ 0.726871] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 0.727788] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 0.729360] pnp: PnP ACPI: found 5 devices hub # [ 0.737168] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.738751] clocksource: Switched to clocksource acpi_pm hub # [ 0.739790] NET: Registered PF_INET protocol family hub # [ 0.741397] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) hub # [ 0.759616] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) hub # [ 0.761267] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.762622] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.764044] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) hub # [ 0.765357] TCP: Hash tables configured (established 32768 bind 32768) hub # [ 0.766606] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) hub # [ 0.768065] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 0.769360] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 0.770686] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.771694] NET: Registered PF_XDP protocol family hub # [ 0.772546] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.773586] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.774611] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.775721] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 0.776881] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 0.778034] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.779921] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 0.782121] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 0.784701] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 0.787018] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 0.788933] PCI: CLS 0 bytes, default 64 hub # [ 0.789886] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) hub # [ 0.791159] Trying to unpack rootfs image as initramfs... hub # [ 0.795046] software IO TLB: mapped [mem 0x000000007a2e6000-0x000000007e2e6000] (64MB) hub # [ 0.796549] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns hub # [ 0.839636] Initialise system trusted keyrings hub # [ 0.843056] workingset: timestamp_bits=40 max_order=20 bucket_order=0 hub # [ 0.862633] Key type asymmetric registered hub # [ 0.867013] Asymmetric key parser 'x509' registered hub # [ 0.867921] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.871108] io scheduler mq-deadline registered hub # [ 0.871926] io scheduler kyber registered hub # [ 0.874566] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.875957] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.881618] Linux agpgart interface v0.103 hub # [ 0.882445] ACPI: bus type drm_connector registered hub # [ 0.885487] usbcore: registered new interface driver usbserial_generic hub # [ 0.886615] usbserial: USB Serial support registered for generic hub # [ 0.890004] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.890004] Please enable it if your BIOS has the CPPC option. hub # [ 0.892332] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.895134] drop_monitor: Initializing network drop monitor service hub # [ 0.896392] NET: Registered PF_INET6 protocol family hub # [ 0.901115] Segment Routing with IPv6 hub # [ 0.901780] In-situ OAM (IOAM) with IPv6 hub # [ 0.905289] IPI shorthand broadcast: enabled hub # [ 0.911774] sched_clock: Marking stable (762016115, 148970536)->(999454742, -88468091) hub # [ 0.917235] registered taskstats version 1 hub # [ 0.918267] Loading compiled-in X.509 certificates hub # [ 0.938390] Demotion targets for Node 0: null hub # [ 0.941035] Key type .fscrypt registered hub # [ 0.941722] Key type fscrypt-provisioning registered hub # [ 0.942735] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.944998] ima: Allocated hash algorithm: sha1 hub # [ 0.945831] ima: No architecture policies found hub # [ 0.949999] PM: Magic number: 2:210:382 hub # [ 0.950727] container PNP0A06:00: hash matches hub # [ 0.951557] acpi PNP0A06:00: hash matches hub # [ 0.956242] RAS: Correctable Errors collector initialized. hub # [ 0.964706] clk: Disabling unused clocks hub # [ 0.967003] PM: genpd: Disabling unused power domains hub # [ 1.146095] Freeing initrd memory: 29608K hub # [ 1.149490] Freeing unused decrypted memory: 2028K hub # [ 1.152333] Freeing unused kernel image (initmem) memory: 3656K hub # [ 1.153461] Write protecting the kernel read-only data: 32768k hub # [ 1.154826] Freeing unused kernel image (text/rodata gap) memory: 304K hub # [ 1.156406] Freeing unused kernel image (rodata/data gap) memory: 692K hub # [ 1.207125] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.208310] Run /init as init process hub # [ 1.219684] systemd[1]: Inserted module 'autofs4' hub # [ 1.239611] fuse: init (API version 7.45) hub # [ 1.246962] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.249673] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.253062] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.255279] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 1.261244] virtiofs virtio5: discovered new tag: nix-store hub # [ 1.262880] virtiofs virtio5: virtio_fs_setup_dax: No cache capability hub # [ 1.270959] virtiofs virtio6: discovered new tag: shared hub # [ 1.272732] virtiofs virtio6: virtio_fs_setup_dax: No cache capability hub # [ 1.276854] virtiofs virtio7: discovered new tag: xchg hub # [ 1.278475] virtiofs virtio7: virtio_fs_setup_dax: No cache capability hub # [ 1.309831] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.646637] 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.687251] systemd[1]: Detected virtualization kvm. hub # [ 1.689371] systemd[1]: Detected architecture x86-64. hub # [ 1.691434] systemd[1]: Running in initrd. hub # [ 1.693850] systemd[1]: Initializing machine ID from random generator. hub # [ 1.696799] systemd[1]: Hostname set to . hub # [ 1.776181] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.814549] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.818339] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.819585] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.821095] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.822240] systemd[1]: Reached target Path Units. hub # [ 1.823162] systemd[1]: Reached target Slice Units. hub # [ 1.824126] systemd[1]: Reached target Swaps. hub # [ 1.824957] systemd[1]: Reached target Timer Units. hub # [ 1.825935] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.827250] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.828489] systemd[1]: Listening on Journal Sockets. hub # [ 1.829536] systemd[1]: Listening on udev Control Socket. hub # [ 1.830608] systemd[1]: Listening on udev Kernel Socket. hub # [ 1.831624] systemd[1]: Reached target Socket Units. hub # [ 1.833473] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 1.838051] systemd[1]: Starting Load Kernel Module configfs... hub # [ 1.849056] systemd[1]: Starting Journal Service... hub # [ 1.858116] systemd[1]: Starting Load Kernel Modules... hub # [ 1.861058] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 1.866053] systemd[1]: Starting Coldplug All udev Devices... hub # [ 1.880088] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 1.885577] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 1.893544] systemd[1]: Finished Load Kernel Module configfs. hub # [ 1.900473] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 1.904626] systemd-journald[65]: Collecting audit messages is disabled. hub # [ 1.912065] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 1.918475] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 1.932145] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 1.962076] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 1.969226] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 1.981061] systemd[1]: Finished Load Kernel Modules. hub # [ 1.989182] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.010095] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.016223] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.021057] systemd[1]: Reached target Local File Systems. hub # [ 2.028064] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.039082] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.047071] systemd[1]: Started Journal Service. hub # [ 1.899201] systemd-modules-load[66]: Inserted module 'dm_mod' hub # [ 1.901428] systemd-modules-load[66]: Inserted module 'virtio_balloon' hub # [ 1.903290] systemd-modules-load[66]: Inserted module 'virtio_gpu' hub # [ 1.913095] systemd[1]: Starting Create System Files and Directories... hub # [ 1.947837] systemd-udevd[73]: Using default interface naming scheme 'v261'. hub # [ 1.948908] systemd[1]: Finished Create System Files and Directories. hub # [ 1.975079] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.034141] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.036113] systemd[1]: Reached target System Initialization. hub # [ 2.038467] systemd[1]: Reached target Basic System. hub # [ 2.392493] virtio_blk virtio2: 1/0/0 default/read/poll queues hub # [ 2.414127] virtio_blk virtio2: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) hub # [ 2.422910] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.451661] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.460708] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 2.461597] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 2.463414] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 hub # [ 2.470802] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.471809] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 2.472671] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 2.473774] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.475992] usb usb1: Product: EHCI Host Controller hub # [ 2.476649] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd hub # [ 2.479985] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 2.480796] hub 1-0:1.0: USB hub found hub # [ 2.482026] hub 1-0:1.0: 6 ports detected hub # [ 2.489287] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 2.490034] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 2.347127] systemd[1]: Starting Virtual Console Setup... hub # [ 2.512063] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.515319] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 2.518837] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 hub # [ 2.372873] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.376205] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.539106] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.540286] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.395125] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.406417] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.563988] usb usb2: Product: UHCI Host Controller hub # [ 2.564657] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 2.419069] systemd[1]: Finished Virtual Console Setup. hub # [ 2.570779] SCSI subsystem initialized hub # [ 2.423754] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.428222] systemd[1]: Reached target Initrd Root Device. hub # [ 2.430852] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 2.582386] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 2.588576] hub 2-0:1.0: USB hub found hub # [ 2.590998] hub 2-0:1.0: 2 ports detected hub # [ 2.600016] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 2.600714] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 2.605776] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 2.606716] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 hub # [ 2.609234] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.612040] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.615026] usb usb3: Product: UHCI Host Controller hub # [ 2.615772] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 2.618238] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 2.622256] hub 3-0:1.0: USB hub found hub # [ 2.625074] hub 3-0:1.0: 2 ports detected hub # [ 2.477154] systemd-fsck[111]: nixos: clean, 12/262144 files, 37198/1048576 blocks hub # [ 2.630763] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 2.631654] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 2.636996] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 2.637756] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 hub # [ 2.639349] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.642869] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.644027] usb usb4: Product: UHCI Host Controller hub # [ 2.644829] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 2.649332] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 2.652313] hub 4-0:1.0: USB hub found hub # [ 2.653760] hub 4-0:1.0: 2 ports detected hub # [ 2.668568] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 2.677387] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 2.680023] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 2.684051] scsi host0: ahci hub # [ 2.685351] scsi host1: ahci hub # [ 2.687049] scsi host2: ahci hub # [ 2.688837] scsi host3: ahci hub # [ 2.691328] scsi host4: ahci hub # [ 2.693023] scsi host5: ahci hub # [ 2.693764] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 47 lpm-pol 1 hub # [ 2.695906] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 47 lpm-pol 1 hub # [ 2.697223] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 47 lpm-pol 1 hub # [ 2.698469] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 47 lpm-pol 1 hub # [ 2.699599] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 47 lpm-pol 1 hub # [ 2.700715] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 47 lpm-pol 1 hub # [ 2.720031] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 2.607774] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.849265] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 2.852221] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 2.855519] usb 1-1: Product: QEMU USB Tablet hub # [ 2.857324] usb 1-1: Manufacturer: QEMU hub # [ 2.859040] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 2.732865] systemd[1]: Mounting /sysroot... hub # [ 2.905541] hid: raw HID events driver (C) Jiri Kosina hub # [ 3.015008] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 3.017319] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 3.019880] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 3.022348] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 3.024783] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 3.026893] ata3.00: applying bridge limits hub # [ 3.028851] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 3.031183] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 3.033344] ata3.00: configured for UDMA/100 hub # [ 3.035830] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 3.113093] usbcore: registered new interface driver usbhid hub # [ 3.113903] usbhid: USB HID core driver hub # [ 3.141433] 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.143165] 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.149015] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 3.160158] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 3.184505] EXT4-fs (vda): mounted filesystem 0584c315-6152-4e74-972a-fe57a4e4bca7 r/w with ordered data mode. Quota mode: none. hub # [ 3.039610] systemd[1]: Mounted /sysroot. hub # [ 3.041182] systemd[1]: Reached target Initrd Root File System. hub # [ 3.042462] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 3.057758] systemd-sysroot-fstab-check[145]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 3.066061] systemd[1]: Reload requested from client PID 145 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 3.067582] systemd[1]: Reloading... hub # [ 3.143281] systemd[1]: Reloading finished in 77 ms. hub # [ 3.151075] systemd-sysroot-fstab-check[145]: Requesting initrd-fs.target/start/replace... hub # [ 3.153248] systemd-sysroot-fstab-check[145]: Requesting swap.target/start/replace... hub # [ 3.156482] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 3.157843] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 3.158889] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 3.733318] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 3.741185] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.750162] systemd[1]: Mounting /sysroot/run... hub # [ 3.759205] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 3.770429] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 3.816490] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.818253] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 3.819079] systemd[1]: Mounted /sysroot/run. hub # [ 3.821370] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.822380] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 3.826069] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 3.836326] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.837778] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 3.839863] systemd[1]: Mounting /sysroot/nix/store... hub # [ 3.860488] systemd[1]: Mounted /sysroot/nix/store. hub # [ 3.861615] systemd[1]: Reached target Initrd File Systems. hub # [ 3.863204] systemd[1]: Starting Find NixOS closure... hub # [ 3.865835] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 3.883115] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 3.889898] systemd[1]: Finished Find NixOS closure. hub # [ 3.891309] systemd[1]: Reached target Initrd Default Target. hub # [ 3.893091] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 3.906370] systemd[1]: Stopped target Initrd Default Target. hub # [ 3.907267] systemd[1]: Stopped target Basic System. hub # [ 3.908062] systemd[1]: Stopped target Initrd Root Device. hub # [ 3.908848] systemd[1]: Stopped target Path Units. hub # [ 3.909553] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 3.910629] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 3.911674] systemd[1]: Stopped target Slice Units. hub # [ 3.912429] systemd[1]: Stopped target Socket Units. hub # [ 3.913198] systemd[1]: Stopped target System Initialization. hub # [ 3.914248] systemd[1]: Stopped target Swaps. hub # [ 3.915407] systemd[1]: Stopped target Timer Units. hub # [ 3.916300] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 3.917352] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 3.918955] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 3.920070] systemd[1]: Stopped Find NixOS closure. hub # [ 3.921081] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 3.921971] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 3.924194] systemd[1]: Stopped Apply Kernel Variables. hub # [ 3.924939] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 3.925985] systemd[1]: Stopped Load Kernel Modules. hub # [ 3.926741] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 3.927868] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 3.928914] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 3.930112] systemd[1]: Stopped Create System Files and Directories. hub # [ 3.932107] systemd[1]: Stopped target Local File Systems. hub # [ 3.932909] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 3.933820] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 3.934813] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 3.936101] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 3.938136] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 3.939209] systemd[1]: Stopped Virtual Console Setup. hub # [ 3.946485] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 3.951218] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 3.959935] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 3.961326] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 3.962853] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.964242] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 3.966166] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 3.967263] systemd[1]: Closed udev Control Socket. hub # [ 3.968893] systemd[1]: Starting Cleanup udev Database... hub # [ 3.970141] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 3.971232] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 3.973126] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 3.974270] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 3.975254] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 3.976253] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 3.990666] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 3.992166] systemd[1]: Finished Cleanup udev Database. hub # [ 3.993576] systemd[1]: Reached target Switch Root. hub # [ 3.995511] systemd[1]: Starting NixOS Activation... hub # [ 4.066429] initrd-nixos-activation-start[196]: booting system configuration /nix/store/rl1kc8z0pmbq1whdp4bd9nw25x3d5qrd-nixos-system-hub-test hub # [ 4.093905] initrd-nixos-activation-start[196]: running activation script... hub # [ 4.292934] initrd-nixos-activation-start[219]: setting up /etc... hub # [ 4.401952] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 4.404094] systemd[1]: Finished NixOS Activation. hub # [ 4.405503] systemd[1]: Starting Switch Root... hub # [ 4.418780] systemd[1]: Switching root. hub # [ 4.693492] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). hub # [ 5.934164] NET: Registered PF_VSOCK protocol family hub # [ 6.309537] 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 # [ 6.347908] systemd[1]: Detected virtualization kvm. hub # [ 6.349719] systemd[1]: Detected architecture x86-64. hub # [ 6.351750] systemd[1]: Detected first boot. hub # [ 6.356042] systemd[1]: Initializing machine ID from random generator. hub # [ 6.459322] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 6.535395] systemd[1]: Applying preset policy. hub # [ 6.714399] systemd[1]: Populated /etc with preset unit settings. hub # [ 6.920318] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 6.921658] systemd[1]: Stopped initrd-switch-root.service. hub # [ 6.924228] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 6.926241] systemd[1]: Created slice Slice /system/getty. hub # [ 6.927583] systemd[1]: Created slice User and Session Slice. hub # [ 6.928493] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 6.929658] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 6.930722] systemd[1]: Expecting device /dev/hvc0... hub # [ 6.931427] systemd[1]: Expecting device /dev/ttyS0... hub # [ 6.932203] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 6.933060] systemd[1]: Stopped target initrd-fs.target. hub # [ 6.933796] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 6.934560] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 6.935386] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 6.936314] systemd[1]: Reached target Path Units. hub # [ 6.937047] systemd[1]: Reached target Remote File Systems. hub # [ 6.937839] systemd[1]: Reached target Slice Units. hub # [ 6.938539] systemd[1]: Reached target Swaps. hub # [ 6.940475] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 6.942980] systemd[1]: Listening on Process Core Dump Socket. hub # [ 6.944757] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 6.946661] systemd[1]: Listening on Factory Reset Management. hub # [ 6.947566] systemd[1]: Listening on Hostname Service Socket. hub # [ 6.950422] systemd[1]: Starting Journal Log Access Socket... hub # [ 6.951550] systemd[1]: Listening on Journal Audit Socket. hub # [ 6.954051] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 6.955425] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 6.956548] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 6.957917] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 6.962159] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 6.963198] systemd[1]: Listening on udev Control Socket. hub # [ 6.964088] systemd[1]: Listening on udev Varlink Socket. hub # [ 6.966465] systemd[1]: Mounting Huge Pages File System... hub # [ 6.968894] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 6.976154] systemd[1]: Mounting Kernel Debug File System... hub # [ 6.983066] systemd[1]: Mounting Kernel Trace File System... hub # [ 6.991480] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 7.001317] systemd[1]: Starting Load Kernel Module configfs... hub # [ 7.006172] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 7.018491] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 7.034547] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 7.042505] systemd[1]: Mounting FUSE Control File System... hub # [ 7.044114] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker: QEMU running (pid 54) worker # Disk image does not exist, creating the virtualisation disk image... hub # [ 7.057463] systemd[1]: Starting Journal Service... worker # Formatting '/build/vm-state-worker/tmp.WvHLKesFJr', fmt=raw size=4294967296 (finished: start all VMs, in 8.32 seconds) worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/1048576 done hub: waiting for unit multi-user.target hub: waiting for the VM to finish booting worker # Creating filesystem with 1048576 4k blocks and 262144 inodes worker # Filesystem UUID: 57c2873e-d973-4fae-a01d-2e0225c59676 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-11-13T13:23:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) worker # [2026-11-13T13:23:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether worker # [2026-11-13T13:23:20Z INFO virtiofsd] Waiting for vhost-user socket connection... worker # [2026-11-13T13:23:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) worker # [2026-11-13T13:23:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether worker # [2026-11-13T13:23:20Z INFO virtiofsd] Waiting for vhost-user socket connection... worker # [2026-11-13T13:23:20Z INFO virtiofsd] Client connected, servicing requests worker # [2026-11-13T13:23:20Z INFO virtiofsd] Client connected, servicing requests hub # [ 7.068395] systemd[1]: Starting Load Kernel Modules... hub # [ 7.077821] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 7.087708] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 7.094062] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.105299] systemd[1]: Starting Coldplug All udev Devices... hub # [ 7.118674] systemd[1]: Listening on Journal Log Access Socket. hub # [ 7.121161] systemd[1]: Mounted Huge Pages File System. hub # [ 7.122367] systemd-journald[289]: Collecting audit messages is enabled. hub # [ 7.125035] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 7.134161] systemd[1]: Mounted Kernel Debug File System. hub # [ 7.140224] systemd[1]: Mounted Kernel Trace File System. hub # [ 7.144688] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 7.148443] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # [ 7.155763] systemd[1]: Finished Load Kernel Module configfs. hub # [ 7.160140] systemd[1]: Mounted FUSE Control File System. hub # [ 7.164555] systemd[1]: Started Journal Service. hub # [ 7.178009] EXT4-fs (vda): re-mounted 0584c315-6152-4e74-972a-fe57a4e4bca7. hub # [ 7.188597] loop: module loaded hub # [ 7.065977] systemd-oomd[291]: No swap; memory pressure usage will be degraded 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 # [ 7.309737] systemd-journald[289]: Received client request to flush runtime journal. worker # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026 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/vldqcxjfkljzy3ix83fvbc2b8c9g23gr-nixos-system-worker-test/init regInfo=/nix/.ro-store/yzmrjs8ha6487phk32v3szmz45xah84v-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.000000] kvm-clock: using sched offset of 474740719 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000004] tsc: Detected 2400.012 MHz processor worker # [ 0.000762] last_pfn = 0x180000 max_arch_pfn = 0x10000000000 worker # [ 0.000788] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000791] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.000829] last_pfn = 0x7ffd5 max_arch_pfn = 0x10000000000 worker # [ 0.002685] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.002696] Using GB pages for direct mapping worker # [ 0.002810] RAMDISK: [mem 0x7e284000-0x7ffcffff] worker # [ 0.002819] ACPI: Early table checksum verification disabled worker # [ 0.002821] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) worker # [ 0.002825] ACPI: RSDT 0x000000007FFE248E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002829] ACPI: FACP 0x000000007FFE227E 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002836] ACPI: DSDT 0x000000007FFE0040 00223E (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002838] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002840] ACPI: APIC 0x000000007FFE2372 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002842] ACPI: HPET 0x000000007FFE23F2 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002843] ACPI: MCFG 0x000000007FFE242A 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002845] ACPI: WAET 0x000000007FFE2466 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002846] ACPI: Reserving FACP table memory at [mem 0x7ffe227e-0x7ffe2371] worker # [ 0.002847] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227d] worker # [ 0.002848] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002848] ACPI: Reserving APIC table memory at [mem 0x7ffe2372-0x7ffe23f1] worker # [ 0.002849] ACPI: Reserving HPET table memory at [mem 0x7ffe23f2-0x7ffe2429] worker # [ 0.002849] ACPI: Reserving MCFG table memory at [mem 0x7ffe242a-0x7ffe2465] worker # [ 0.002850] ACPI: Reserving WAET table memory at [mem 0x7ffe2466-0x7ffe248d] worker # [ 0.003079] No NUMA configuration found worker # [ 0.003080] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] worker # [ 0.003082] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff] worker # [ 0.005273] Zone ranges: worker # [ 0.005274] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.005275] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] worker # [ 0.005276] Normal [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.005277] Device empty worker # [ 0.005278] Movable zone start for each node worker # [ 0.005279] Early memory node ranges worker # [ 0.005279] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005280] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.005281] node 0: [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.005282] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] worker # [ 0.005301] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.005552] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.072727] On node 0, zone Normal: 43 pages in unavailable ranges worker # [ 0.073212] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.073228] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.073263] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.073266] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.073267] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.073269] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.073270] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.073270] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.073273] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.073274] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.073278] TSC deadline timer available worker # [ 0.073283] CPU topo: Max. logical packages: 1 worker # [ 0.073283] CPU topo: Max. logical dies: 1 worker # [ 0.073284] CPU topo: Max. dies per package: 1 worker # [ 0.073287] CPU topo: Max. threads per core: 1 worker # [ 0.073288] CPU topo: Num. cores per package: 2 worker # [ 0.073288] CPU topo: Num. threads per package: 2 worker # [ 0.073288] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs worker # [ 0.073312] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.073327] kvm-guest: KVM setup pv remote TLB flush worker # [ 0.073329] kvm-guest: setup PV sched yield worker # [ 0.073339] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.073341] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.073342] PM: hibernation: Registered nosave memory: [mem 0x7ffd5000-0xffffffff] worker # [ 0.073343] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.073345] Booting paravirtualized kernel on KVM worker # [ 0.073348] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.077993] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 worker # [ 0.080244] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u1048576 worker # [ 0.080294] kvm-guest: PV spinlocks enabled worker # [ 0.080296] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) worker # [ 0.080299] 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/vldqcxjfkljzy3ix83fvbc2b8c9g23gr-nixos-system-worker-test/init regInfo=/nix/.ro-store/yzmrjs8ha6487phk32v3szmz45xah84v-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.080399] Unknown kernel command line parameters "regInfo=/nix/.ro-store/yzmrjs8ha6487phk32v3szmz45xah84v-closure-info/registration", will be passed to user space. worker # [ 0.080413] random: crng init done worker # [ 0.080413] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.084491] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) worker # [ 0.086536] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.086583] software IO TLB: area num 2. worker # [ 0.156057] Fallback order for Node 0: 0 worker # [ 0.156064] Built 1 zonelists, mobility grouping on. Total pages: 1048435 worker # [ 0.156066] Policy zone: Normal worker # [ 0.158618] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.165515] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 worker # [ 0.174036] allocated 8388608 bytes of page_ext worker # [ 0.183850] ftrace: allocating 48837 entries in 192 pages worker # [ 0.183851] ftrace: allocated 192 pages with 2 groups worker # [ 0.184684] Dynamic Preempt: lazy worker # [ 0.184870] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.184870] rcu: RCU event tracing is enabled. worker # [ 0.184871] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. worker # [ 0.184872] Trampoline variant of Tasks RCU enabled. worker # [ 0.184873] Rude variant of Tasks RCU enabled. worker # [ 0.184873] Tracing variant of Tasks RCU enabled. worker # [ 0.184874] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.184874] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 worker # [ 0.184893] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.184895] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.184896] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.189157] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 worker # [ 0.189447] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.189456] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.189557] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.193136] Console: colour VGA+ 80x25 worker # [ 0.193138] printk: legacy console [tty0] enabled worker # [ 0.224733] printk: legacy console [ttyS0] enabled worker # [ 0.334047] ACPI: Core revision 20250807 worker # [ 0.334955] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.336687] APIC: Switch to symmetric I/O mode setup worker # [ 0.337703] x2apic enabled worker # [ 0.338489] APIC: Switched APIC routing to: physical x2apic worker # [ 0.339444] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() worker # [ 0.340657] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() worker # [ 0.342181] kvm-guest: setup PV IPIs worker # [ 0.343769] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.344804] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns worker # [ 0.349114] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) worker # [ 0.350197] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.352211] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.353110] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.354114] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.355111] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.357111] Transient Scheduler Attacks: Vulnerable: No microcode worker # [ 0.358110] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.359110] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.360110] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.361118] Spectre V2 : Enabling IBPB for BPF worker # [ 0.362667] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.363111] active return thunk: srso_alias_return_thunk worker # [ 0.364132] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.365110] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.366110] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.367110] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.368110] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.369110] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' worker # [ 0.370110] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.372110] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.373110] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 worker # [ 0.374110] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 worker # [ 0.375110] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.376110] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.377111] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. hub # [ 7.751275] (udev-worker)[367]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 0.405930] Freeing SMP alternatives memory: 48K worker # [ 0.406701] pid_max: default: 32768 minimum: 301 worker # [ 0.407196] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.408211] landlock: Up and running. worker # [ 0.409111] Yama: becoming mindful. worker # [ 0.410312] LSM support for eBPF active worker # [ 0.411181] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.412185] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.414991] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.415690] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.416115] ... version: 2 worker # [ 0.416837] ... bit width: 48 worker # [ 0.417113] ... generic counters: 6 worker # [ 0.417869] ... generic bitmap: 000000000000003f worker # [ 0.418125] ... fixed-purpose counters: 0 worker # [ 0.418885] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.419113] ... value mask: 0000ffffffffffff worker # [ 0.420013] ... max period: 00007fffffffffff worker # [ 0.420818] ... global_ctrl mask: 000000000000003f worker # [ 0.421225] signal: max sigframe size: 3376 worker # [ 0.422008] rcu: Hierarchical SRCU implementation. worker # [ 0.422759] rcu: Max phase no-delay instances is 400. worker # [ 0.423299] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level worker # [ 0.428578] smp: Bringing up secondary CPUs ... worker # [ 0.429438] smpboot: x86: Booting SMP configuration: worker # [ 0.430116] .... node #0, CPUs: #1 worker # [ 0.431149] smp: Brought up 1 node, 2 CPUs worker # [ 0.432662] smpboot: Total of 2 processors activated (9600.04 BogoMIPS) worker # [ 0.433446] Memory: 3957656K/4193740K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 220992K reserved, 0K cma-reserved) worker # [ 0.435115] devtmpfs: initialized worker # [ 0.436222] x86/mm: Memory block size: 128MB worker # [ 0.439184] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.440152] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). worker # [ 0.441200] pinctrl core: initialized pinctrl subsystem worker # [ 0.442304] PM: RTC time: 13:23:20, date: 2026-11-13 worker # [ 0.446070] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.447672] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.448142] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.449655] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.450124] audit: initializing netlink subsys (disabled) worker # [ 0.451161] audit: type=2000 audit(1794576201.524:1): state=initialized audit_enabled=0 res=1 worker # [ 0.451335] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.453114] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.454113] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.455113] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.456113] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.457129] cpuidle: using governor menu worker # [ 0.459304] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.460350] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.461116] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.462126] PCI: Using configuration type 1 for base access worker # [ 0.463229] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.470137] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.471117] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.472113] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.476113] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.481586] ACPI: Added _OSI(Module Device) worker # [ 0.482115] ACPI: Added _OSI(Processor Device) worker # [ 0.482907] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.486439] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.491289] ACPI: Interpreter enabled worker # [ 0.492195] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.493117] ACPI: Using IOAPIC for interrupt routing worker # [ 0.494132] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.495113] PCI: Using E820 reservations for host bridge windows worker # [ 0.496282] ACPI: Enabled 2 GPEs in block 00 to 3F worker # [ 0.501196] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.502119] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.503194] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.504239] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.505474] PCI host bridge to bus 0000:00 worker # [ 0.506117] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.507113] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.508113] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.509113] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.510113] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.511113] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.512114] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.513172] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.514596] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.517190] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.518126] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.519135] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.520284] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.521832] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.525151] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.526026] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.527135] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] worker # [ 0.528120] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.529837] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.533081] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.533794] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.534135] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] worker # [ 0.535651] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.537948] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.538810] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.539134] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] worker # [ 0.540647] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.544151] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.545063] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.545903] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] worker # [ 0.547679] pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.550590] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.551816] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.552135] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] worker # [ 0.553119] pci 0000:00:06.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.554677] pci 0000:00:07.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.556125] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.557134] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] worker # [ 0.559418] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint worker # [ 0.563151] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.564136] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] worker # [ 0.565704] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint worker # [ 0.568038] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.568915] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] worker # [ 0.570657] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.573150] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.574066] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.574904] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] worker # [ 0.576637] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.579146] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.580062] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.580909] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] worker # [ 0.582625] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.584131] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.585136] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] worker # [ 0.587196] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.588836] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] worker # [ 0.589338] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.590784] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] worker # [ 0.591333] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.592771] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] worker # [ 0.593391] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint worker # [ 0.595769] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] worker # [ 0.596357] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.597400] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 0.598372] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint worker # [ 0.600141] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] worker # [ 0.601052] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] worker # [ 0.602432] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.603808] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] worker # [ 0.607327] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.608231] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.609214] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.610216] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.611219] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.612213] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 0.613235] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.614216] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.615148] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.616126] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.617126] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.618125] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 0.619125] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.620131] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.621125] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.622130] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 0.624191] iommu: Default domain type: Translated worker # [ 0.626123] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.630851] ACPI: bus type USB registered worker # [ 0.632485] usbcore: registered new interface driver usbfs worker # [ 0.634212] usbcore: registered new interface driver hub worker # [ 0.637155] usbcore: registered new device driver usb worker # [ 0.640724] NetLabel: Initializing worker # [ 0.641115] NetLabel: domain hash size = 128 worker # [ 0.641838] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.642150] NetLabel: unlabeled traffic allowed by default worker # [ 0.643075] PCI: Using ACPI for IRQ routing worker # [ 0.695272] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.696109] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.696109] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.703133] vgaarb: loaded worker # [ 0.704647] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.707117] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 8.291616] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 0.713144] clocksource: Switched to clocksource kvm-clock worker # [ 0.718437] VFS: Disk quotas dquot_6.6.0 worker # [ 0.719219] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.720750] pnp: PnP ACPI init worker # [ 0.721526] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 0.723110] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 0.726937] pnp: PnP ACPI: found 5 devices worker # [ 0.739259] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.742131] clocksource: Switched to clocksource acpi_pm worker # [ 0.744216] NET: Registered PF_INET protocol family worker # [ 0.747064] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) worker # [ 0.766941] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) worker # [ 0.768535] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.770122] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.775919] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) worker # [ 0.779133] TCP: Hash tables configured (established 32768 bind 32768) worker # [ 0.782095] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) worker # [ 0.785185] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 0.787391] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 0.789985] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.791918] NET: Registered PF_XDP protocol family worker # [ 0.793541] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.795505] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.797461] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.799601] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 8.321917] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 0.801900] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 0.804117] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.807834] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 0.812139] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 0.816283] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 0.820270] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 0.822204] PCI: CLS 0 bytes, default 64 worker # [ 0.823042] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) worker # [ 0.823307] Trying to unpack rootfs image as initramfs... worker # [ 0.824125] software IO TLB: mapped [mem 0x000000007a284000-0x000000007e284000] (64MB) worker # [ 0.824266] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns worker # [ 0.848013] Initialise system trusted keyrings worker # [ 0.849038] workingset: timestamp_bits=40 max_order=20 bucket_order=0 worker # [ 0.859871] Key type asymmetric registered worker # [ 0.860594] Asymmetric key parser 'x509' registered worker # [ 0.861503] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.862996] io scheduler mq-deadline registered worker # [ 0.863817] io scheduler kyber registered worker # [ 0.866036] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.867348] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.869514] Linux agpgart interface v0.103 worker # [ 0.870315] ACPI: bus type drm_connector registered worker # [ 0.875013] usbcore: registered new interface driver usbserial_generic worker # [ 0.876134] usbserial: USB Serial support registered for generic worker # [ 0.877138] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. worker # [ 0.877138] Please enable it if your BIOS has the CPPC option. worker # [ 0.879352] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.880749] drop_monitor: Initializing network drop monitor service worker # [ 0.881947] NET: Registered PF_INET6 protocol family worker # [ 0.885162] Segment Routing with IPv6 worker # [ 0.885850] In-situ OAM (IOAM) with IPv6 worker # [ 0.887966] IPI shorthand broadcast: enabled worker # [ 0.892352] sched_clock: Marking stable (741011338, 150653451)->(968703256, -77038467) worker # [ 0.893919] registered taskstats version 1 worker # [ 0.894893] Loading compiled-in X.509 certificates worker # [ 0.904774] Demotion targets for Node 0: null worker # [ 0.905729] Key type .fscrypt registered worker # [ 0.906394] Key type fscrypt-provisioning registered worker # [ 0.907374] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.908307] ima: Allocated hash algorithm: sha1 worker # [ 0.909129] ima: No architecture policies found worker # [ 0.910093] PM: Magic number: 2:210:382 worker # [ 0.910839] container PNP0A06:00: hash matches worker # [ 0.911573] acpi PNP0A06:00: hash matches worker # [ 0.913103] RAS: Correctable Errors collector initialized. worker # [ 0.917679] clk: Disabling unused clocks worker # [ 0.918349] PM: genpd: Disabling unused power domains hub # [ 8.411900] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 worker # [ 1.091707] Freeing initrd memory: 30000K worker # [ 1.098813] Freeing unused decrypted memory: 2028K worker # [ 1.105178] Freeing unused kernel image (initmem) memory: 3656K worker # [ 1.107839] Write protecting the kernel read-only data: 32768k worker # [ 1.111181] Freeing unused kernel image (text/rodata gap) memory: 304K worker # [ 1.114851] Freeing unused kernel image (rodata/data gap) memory: 692K hub # [ 8.449540] rtc_cmos PNP0B00:00: RTC can wake from S4 hub # [ 8.470298] ACPI: button: Power Button [PWRF] hub # [ 8.485472] rtc_cmos PNP0B00:00: registered as rtc0 hub # [ 8.485548] rtc_cmos PNP0B00:00: setting system clock to 2026-11-13T13:23:22 UTC (1794576202) hub # [ 8.485628] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 8.498111] mousedev: PS/2 mouse device common for all mice hub # [ 8.499420] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 1.182335] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.183454] Run /init as init process hub # [ 8.637263] systemd-ssh-issue[529]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # [ 1.195983] systemd[1]: Inserted module 'autofs4' hub # [ 8.499522] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 8.583856] Console: switching to colour dummy device 80x25 hub # [ 8.597531] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 1.231882] fuse: init (API version 7.45) worker # [ 1.240592] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.243149] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.247114] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 8.725422] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt hub # [ 8.725540] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD hub # [ 8.812369] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 1.252187] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.266974] virtiofs virtio6: discovered new tag: shared worker # [ 1.270753] virtiofs virtio6: virtio_fs_setup_dax: No cache capability worker # [ 1.283186] virtiofs virtio7: discovered new tag: xchg worker # [ 1.287188] virtiofs virtio7: virtio_fs_setup_dax: No cache capability hub # [ 8.812606] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 8.895520] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 8.895522] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 1.337957] systemd[1]: Successfully made /usr/ read-only. hub # [ 8.950438] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic hub # [ 8.951205] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 hub # [ 9.002564] ppdev: user-space parallel port driver hub # connecting to host... hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 2.05 seconds) hub: (finished: waiting for the VM to finish booting, in 2.05 seconds) hub # [ 9.186616] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # [ 9.196068] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) hub # [ 9.231557] Console: switching to colour frame buffer device 160x50 hub # [ 9.260856] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 1.676629] 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.688719] systemd[1]: Detected virtualization kvm. worker # [ 1.690841] systemd[1]: Detected architecture x86-64. worker # [ 1.692976] systemd[1]: Running in initrd. worker # [ 1.695389] systemd[1]: Initializing machine ID from random generator. worker # [ 1.698251] systemd[1]: Hostname set to . worker # [ 1.794310] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 1.835173] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 1.848251] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.851244] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.854823] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.857599] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.860335] systemd[1]: Reached target Path Units. worker # [ 1.862458] systemd[1]: Reached target Slice Units. worker # [ 1.864605] systemd[1]: Reached target Swaps. worker # [ 1.866597] systemd[1]: Reached target Timer Units. worker # [ 1.869066] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 1.872030] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 1.874833] systemd[1]: Listening on Journal Sockets. worker # [ 1.877410] systemd[1]: Listening on udev Control Socket. worker # [ 1.879938] systemd[1]: Listening on udev Kernel Socket. hub # [ 9.462173] kvm_amd: TSC scaling supported hub # [ 9.462630] kvm_amd: Nested Virtualization enabled worker # [ 1.882255] systemd[1]: Reached target Socket Units. hub # [ 9.464981] kvm_amd: Nested Paging enabled hub # [ 9.465372] kvm_amd: LBR virtualization supported hub # [ 9.465838] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 9.467980] kvm_amd: Virtual GIF supported hub # [ 9.468373] kvm_amd: Virtual NMI enabled worker # [ 1.886860] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 1.891823] systemd[1]: Starting Load Kernel Module configfs... worker # [ 1.905483] systemd[1]: Starting Journal Service... worker # [ 1.910814] systemd[1]: Starting Load Kernel Modules... worker # [ 1.912807] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.919285] systemd[1]: Starting Coldplug All udev Devices... worker # [ 1.923546] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 1.929313] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 1.933721] systemd-journald[74]: Collecting audit messages is disabled. worker # [ 1.934708] systemd[1]: Finished Load Kernel Module configfs. worker # [ 1.936375] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 1.943025] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 9.526826] EDAC MC: Ver: 3.0.0 worker # [ 1.963008] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 1.967005] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 1.968797] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 1.973760] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 1.975412] systemd[1]: Finished Load Kernel Modules. worker # [ 1.985872] systemd[1]: Starting Apply Kernel Variables... worker # [ 1.855345] systemd-modules-load[75]: Using 2 probe threads worker # [ 1.857435] systemd-modules-load[75]: Inserted module 'virtio_balloon' worker # [ 1.858625] systemd-modules-load[75]: Inserted module 'virtio_gpu' worker # [ 2.009860] systemd[1]: Started Journal Service. worker # [ 1.859695] systemd-modules-load[75]: Inserted module 'dm_mod' worker # [ 1.862385] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 1.864275] systemd[1]: Finished Apply Kernel Variables. worker # [ 1.867822] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 1.869143] systemd[1]: Reached target Local File Systems. worker # [ 1.870290] systemd[1]: Starting Create System Files and Directories... worker # [ 1.874509] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 1.897610] systemd[1]: Finished Create System Files and Directories. worker # [ 1.905984] systemd-udevd[90]: Using default interface naming scheme 'v261'. worker # [ 1.918879] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 1.929307] systemd[1]: Finished Coldplug All udev Devices. worker # [ 1.930206] systemd[1]: Reached target System Initialization. worker # [ 1.930991] systemd[1]: Reached target Basic System. worker # [ 2.189081] virtio_blk virtio2: 2/0/0 default/read/poll queues worker # [ 2.201896] virtio_blk virtio2: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) worker # [ 2.202808] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 2.205155] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1 worker # [ 2.206259] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 2.207164] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 worker # [ 2.208210] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.209365] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.210507] usb usb1: Product: UHCI Host Controller worker # [ 2.212384] virtio_blk virtio3: 2/0/0 default/read/poll queues worker # [ 2.214330] virtio_blk virtio3: [vdb] 2667056 512-byte logical blocks (1.37 GB/1.27 GiB) worker # [ 2.215241] usb usb1: Manufacturer: Linux 6.18.55 uhci_hcd worker # [ 2.216562] usb usb1: SerialNumber: 0000:00:1d.0 worker # [ 2.223917] hub 1-0:1.0: USB hub found worker # [ 2.227118] hub 1-0:1.0: 2 ports detected worker # [ 2.230615] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 2.231458] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2 worker # [ 2.232937] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 worker # [ 2.239696] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 2.240682] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 2.241840] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.242862] usb usb2: Product: EHCI Host Controller worker # [ 2.244065] usb usb2: Manufacturer: Linux 6.18.55 ehci_hcd worker # [ 2.245473] usb usb2: SerialNumber: 0000:00:1d.7 worker # [ 2.247206] hub 2-0:1.0: USB hub found worker # [ 2.247810] hub 2-0:1.0: 6 ports detected hub # [ 9.837566] 8021q: 802.1Q VLAN Support v1.8 hub # [ 9.838287] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 2.264506] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.269704] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.270383] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.271288] hub 1-0:1.0: USB hub found worker # [ 2.271915] hub 1-0:1.0: 2 ports detected worker # [ 2.273924] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 2.274710] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 2.280584] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 2.282341] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 worker # [ 2.285391] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.286812] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.288998] usb usb3: Product: UHCI Host Controller worker # [ 2.293244] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd worker # [ 2.146970] (udev-worker)[105]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.299945] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 2.156341] (udev-worker)[104]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.[ 2.307352] hub 3-0:1.0: USB hub found worker # worker # [ 2.159417] (udev-worker)[104]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.160671] systemd[1]: Starting Virtual Console Setup... worker # [ 2.319104] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.331716] hub 3-0:1.0: 2 ports detected worker # [ 2.185815] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.339881] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 2.342693] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 2.343820] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 2.344617] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 worker # [ 2.194768] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.197671] systemd[1]: Reached target Initrd Root Device. worker # [ 2.200108] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.352155] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.353394] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.354459] usb usb4: Product: UHCI Host Controller worker # [ 2.206387] systemd-vconsole-setup[119]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.209649] systemd[1]: Finished Virtual Console Setup. worker # [ 2.361525] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd worker # [ 2.362453] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 2.364099] SCSI subsystem initialized worker # [ 2.364897] hub 4-0:1.0: USB hub found worker # [ 2.365714] hub 4-0:1.0: 2 ports detected hub # [ 9.950365] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 2.229324] systemd-fsck[125]: nixos: clean, 12/262144 files, 37198/1048576 blocks worker # [ 2.234115] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 9.966788] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 9.967472] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 9.969538] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 9.970428] cfg80211: failed to load regulatory.db worker # [ 2.404237] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 2.405667] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 2.406503] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 2.409988] scsi host0: ahci worker # [ 2.411572] scsi host1: ahci worker # [ 2.412236] scsi host2: ahci worker # [ 2.413314] scsi host3: ahci worker # [ 2.414183] scsi host4: ahci worker # [ 2.415193] scsi host5: ahci worker # [ 2.415883] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 48 lpm-pol 1 worker # [ 2.417016] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 48 lpm-pol 1 worker # [ 2.418278] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 48 lpm-pol 1 worker # [ 2.419496] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 48 lpm-pol 1 worker # [ 2.420696] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 48 lpm-pol 1 worker # [ 2.421897] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 48 lpm-pol 1 hub # [ 9.856837] systemd-vconsole-setup[638]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 10.011738] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 2.484767] usb 2-1: new high-speed USB device number 2 using ehci-pci hub # [ 10.094967] NET: Registered PF_PACKET protocol family worker # [ 2.618579] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 2.621545] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 2.624218] usb 2-1: Product: QEMU USB Tablet worker # [ 2.625858] usb 2-1: Manufacturer: QEMU worker # [ 2.627387] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 2.666556] hid: raw HID events driver (C) Jiri Kosina worker # [ 2.740014] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 2.742462] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 2.744977] ata3.00: applying bridge limits worker # [ 2.746777] ata3.00: configured for UDMA/100 worker # [ 2.748752] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 2.751041] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 2.753276] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 2.755479] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 2.757768] ata2: SATA link down (SStatus 0 SControl 300) worker # [ 2.760511] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 2.803847] usbcore: registered new interface driver usbhid worker # [ 2.807758] usbhid: USB HID core driver worker # [ 2.817242] 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.841162] 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.858929] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 2.889940] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 2.772856] systemd[1]: Mounting /sysroot... worker # [ 3.079017] EXT4-fs (vda): mounted filesystem 57c2873e-d973-4fae-a01d-2e0225c59676 r/w with ordered data mode. Quota mode: none. worker # [ 2.934264] systemd[1]: Mounted /sysroot. worker # [ 2.936869] systemd[1]: Reached target Initrd Root File System. worker # [ 2.939675] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 2.941656] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 2.945805] systemd[1]: Mounting /sysroot/run... worker # [ 2.949117] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 2.953417] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 2.959488] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 3.124101] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 2.977354] systemd-sysroot-fstab-check[166]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 2.980033] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 2.981842] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 2.982688] systemd[1]: Mounted /sysroot/run. worker # [ 2.986847] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 2.988608] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 2.991050] systemd[1]: Reload requested from client PID 166 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 2.992655] systemd[1]: Reloading... worker # [ 3.056477] systemd[1]: Reloading finished in 62 ms. worker # [ 3.077057] systemd-sysroot-fstab-check[166]: Requesting initrd-fs.target/start/replace... worker # [ 3.080617] systemd-sysroot-fstab-check[166]: Requesting swap.target/start/replace... worker # [ 3.084072] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.087099] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.093690] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.094823] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.100729] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.101933] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.774485] systemd[1]: Mounting /sysroot/nix/store... worker # [ 3.828643] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.830279] systemd[1]: Reached target Initrd File Systems. worker # [ 3.832666] systemd[1]: Starting Find NixOS closure... worker # [ 3.836290] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 3.865607] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 3.867831] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 3.880842] systemd[1]: Finished Find NixOS closure. worker # [ 3.881666] systemd[1]: Reached target Initrd Default Target. worker # [ 3.883767] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 3.910408] systemd[1]: Stopped target Initrd Default Target. worker # [ 3.912127] systemd[1]: Stopped target Basic System. worker # [ 3.913478] systemd[1]: Stopped target Initrd Root Device. worker # [ 3.914900] systemd[1]: Stopped target Path Units. worker # [ 3.916194] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 3.918478] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 3.920683] systemd[1]: Stopped target Slice Units. worker # [ 3.922227] systemd[1]: Stopped target Socket Units. worker # [ 3.923992] systemd[1]: Stopped target System Initialization. worker # [ 3.925690] systemd[1]: Stopped target Swaps. worker # [ 3.927043] systemd[1]: Stopped target Timer Units. worker # [ 3.928471] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 3.929579] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 3.930482] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 3.931597] systemd[1]: Stopped Find NixOS closure. worker # [ 3.932327] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.933187] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 3.935415] systemd[1]: Stopped Apply Kernel Variables. worker # [ 3.936177] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 3.937263] systemd[1]: Stopped Load Kernel Modules. worker # [ 3.938032] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 3.939159] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 3.940267] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 3.941414] systemd[1]: Stopped Create System Files and Directories. worker # [ 3.945028] systemd[1]: Stopped target Local File Systems. worker # [ 3.945815] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 3.947280] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 3.948472] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 3.949687] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 3.950791] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 3.951806] systemd[1]: Stopped Virtual Console Setup. worker # [ 3.952656] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 3.953659] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 3.954662] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.955731] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.956688] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 3.957672] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 3.958682] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 3.959660] systemd[1]: Closed udev Control Socket. worker # [ 3.960410] systemd[1]: Starting Cleanup udev Database... worker # [ 3.961215] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 3.962287] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 3.963168] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 3.964334] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 3.965365] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 3.966507] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 3.974661] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 3.975806] systemd[1]: Finished Cleanup udev Database. worker # [ 3.976615] systemd[1]: Reached target Switch Root. worker # [ 3.977369] systemd[1]: Starting NixOS Activation... worker # [ 4.055971] initrd-nixos-activation-start[211]: booting system configuration /nix/store/vldqcxjfkljzy3ix83fvbc2b8c9g23gr-nixos-system-worker-test worker # [ 4.096122] initrd-nixos-activation-start[211]: running activation script... worker # [ 4.308805] initrd-nixos-activation-start[234]: setting up /etc... worker # [ 4.403854] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.406262] systemd[1]: Finished NixOS Activation. worker # [ 4.411094] systemd[1]: Starting Switch Root... worker # [ 4.437621] systemd[1]: Switching root. worker # [ 4.642224] systemd-journald[74]: Received SIGTERM from PID 1 (systemd). worker # [ 4.760664] NET: Registered PF_VSOCK protocol family worker # [ 5.130162] 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.139913] systemd[1]: Detected virtualization kvm. worker # [ 5.141704] systemd[1]: Detected architecture x86-64. worker # [ 5.143595] systemd[1]: Detected first boot. worker # [ 5.146200] systemd[1]: Initializing machine ID from random generator. worker # [ 5.258394] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 5.351615] systemd[1]: Applying preset policy. worker # [ 5.480367] systemd[1]: Populated /etc with preset unit settings. worker # [ 5.579472] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.582958] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.587548] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.592871] systemd[1]: Created slice Slice /system/getty. worker # [ 5.596431] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 5.600281] systemd[1]: Created slice User and Session Slice. worker # [ 5.602575] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 5.605593] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.608312] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.610164] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.612066] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.614162] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.616040] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.618070] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.620248] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.622552] systemd[1]: Reached target Path Units. worker # [ 5.624036] systemd[1]: Reached target Remote File Systems. worker # [ 5.625591] systemd[1]: Reached target Slice Units. worker # [ 5.627101] systemd[1]: Reached target Swaps. worker # [ 5.630031] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.633880] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.636525] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.639582] systemd[1]: Listening on Factory Reset Management. worker # [ 5.641153] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.643537] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.645118] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.649381] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 5.652171] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.654952] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.658211] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 5.664751] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.667305] systemd[1]: Listening on udev Control Socket. worker # [ 5.669483] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.674621] systemd[1]: Mounting Huge Pages File System... worker # [ 5.679765] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 5.683142] systemd[1]: Mounting Kernel Debug File System... worker # [ 5.688713] systemd[1]: Mounting Kernel Trace File System... worker # [ 5.693406] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 5.697089] systemd[1]: Starting Load Kernel Module configfs... worker # [ 5.697995] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 5.700146] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 5.706440] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.713716] systemd[1]: Mounting FUSE Control File System... worker # [ 5.714525] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 5.723725] systemd[1]: Starting Journal Service... worker # [ 5.729186] systemd[1]: Starting Load Kernel Modules... worker # [ 5.734220] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 5.738710] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 5.739601] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.747327] systemd[1]: Starting Coldplug All udev Devices... worker # [ 5.751511] systemd[1]: Listening on Journal Log Access Socket. worker # [ 5.753316] systemd[1]: Mounted Huge Pages File System. worker # [ 5.754304] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 5.755896] systemd[1]: Mounted Kernel Debug File System. worker # [ 5.756929] systemd[1]: Mounted Kernel Trace File System. worker # [ 5.759260] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 5.761554] systemd-journald[305]: Collecting audit messages is enabled. worker # [ 5.762856] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 5.764293] systemd[1]: Finished Load Kernel Module configfs. worker # [ 5.765684] loop: module loaded worker # [ 5.765801] systemd[1]: Mounted FUSE Control File System. worker # [ 5.769785] EXT4-fs (vda): re-mounted 57c2873e-d973-4fae-a01d-2e0225c59676. worker # [ 5.773731] systemd[1]: Mounting Kernel Configuration File System... worker # [ 5.779731] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 5.782004] systemd[1]: Finished Load Kernel Modules. worker # [ 5.783340] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 5.786460] systemd[1]: Mounted Kernel Configuration File System. worker # [ 5.787735] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 5.792766] systemd[1]: Starting Firewall... worker # [ 5.793460] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 5.798728] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 5.802820] systemd[1]: Starting Apply Kernel Variables... worker # [ 5.803708] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.817187] systemd[1]: Started Journal Service. worker # [ 5.675772] systemd-oomd[308]: No swap; memory pressure usage will be degraded worker # [ 5.858214] systemd-journald[305]: Received client request to flush runtime journal. worker # [ 6.006856] (udev-worker)[388]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 6.235739] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.255446] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 6.269812] Console: switching to colour dummy device 80x25 worker # [ 6.270545] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 6.271782] ACPI: button: Power Button [PWRF] worker # [ 6.272599] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 6.276247] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 6.277063] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 6.278242] rtc_cmos PNP0B00:00: RTC can wake from S4 worker # [ 6.280551] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:07.0/virtio5/input/input4 worker # [ 6.292700] rtc_cmos PNP0B00:00: registered as rtc0 worker # [ 6.293260] rtc_cmos PNP0B00:00: setting system clock to 2026-11-13T13:23:26 UTC (1794576206) worker # [ 6.295032] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 6.296181] systemd-journald[305]: Time jumped backwards, rotating. worker # [ 6.300732] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 6.306321] Console: switching to colour frame buffer device 160x50 worker # [ 6.309072] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 6.310775] mousedev: PS/2 mouse device common for all mice worker # [ 6.328401] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 6.330688] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 6.352598] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 6.363249] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 6.371573] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 6.372993] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 6.511656] ppdev: user-space parallel port driver worker # [ 6.516964] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 6.519401] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 6.541446] kvm_amd: TSC scaling supported worker # [ 6.541980] kvm_amd: Nested Virtualization enabled worker # [ 6.542425] kvm_amd: Nested Paging enabled worker # [ 6.543101] kvm_amd: LBR virtualization supported worker # [ 6.543543] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 6.544315] kvm_amd: Virtual GIF supported worker # [ 6.544867] kvm_amd: Virtual NMI enabled worker # [ 6.409555] systemd-vconsole-setup[478]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 6.611144] EDAC MC: Ver: 3.0.0 worker # [ 6.784963] systemd-ssh-issue[556]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # connecting to host... worker # [ 7.238986] 8021q: 802.1Q VLAN Support v1.8 worker # [ 7.239435] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 7.323452] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 7.328879] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 7.330114] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 7.332379] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 7.333478] cfg80211: failed to load regulatory.db worker # [ 7.369893] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 7.545195] NET: Registered PF_PACKET protocol family hub: (finished: waiting for unit multi-user.target, in 8.90 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 5.28 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----- MIIBWDCB/6ADAgECAhRNfpLwWOXhkdGu5fCI+B8XBGHQBzAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MTExMzEzMjMz NVoXDTI4MTExMjEzMjMzNVowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABEH6+XVC0q0HdZZgc08YyW7a N5x9AUaHxtSGcuamLWL8/BIhlG2DnC+yMSE6gGNdY4jrzIHNdpPwwRE+CaAbkS2j FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNIADBFAiEA+Mn4sCWj +wzMinlHLjv8SZAPoVFiFOSqMFbxqT+eFDYCIEsEycxqu0JVTWyAmqvWX2HMKyBr Sa6tzYDXfD1xT38O -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBWDCB/6ADAgECAhRNfpLwWOXhkdGu5fCI+B8XBGHQBzAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MTExMzEzMjMz NVoXDTI4MTExMjEzMjMzNVowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABEH6+XVC0q0HdZZgc08YyW7a N5x9AUaHxtSGcuamLWL8/BIhlG2DnC+yMSE6gGNdY4jrzIHNdpPwwRE+CaAbkS2j FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNIADBFAiEA+Mn4sCWj +wzMinlHLjv8SZAPoVFiFOSqMFbxqT+eFDYCIEsEycxqu0JVTWyAmqvWX2HMKyBr Sa6tzYDXfD1xT38O -----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----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgF+X9Llvw8Np4zCtk HEFCYlI3NV+QJeEFismZ2XjT61uhRANCAARB+vl1QtKtB3WWYHNPGMlu2jecfQFG h8bUhnLmpi1i/PwSIZRtg5wvsjEhOoBjXWOI68yBzXaT8MERPgmgG5Et -----END PRIVATE KEY----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgF+X9Llvw8Np4zCtk HEFCYlI3NV+QJeEFismZ2XjT61uhRANCAARB+vl1QtKtB3WWYHNPGMlu2jecfQFG h8bUhnLmpi1i/PwSIZRtg5wvsjEhOoBjXWOI68yBzXaT8MERPgmgG5Et -----END PRIVATE KEY----- PEMEOF, in 0.02 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----- MIIBjzCCATWgAwIBAgIUakyDv9YuXHQ/cC6FWmHrwXo629gwCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjExMTMxMzIz MzVaFw0zNjExMTAxMzIzMzVaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQg5GuSjmV0V0T8D8wYsec+ Qcfx85yB8bmlvn2CVih9B8QTuQo8ii9sPrlUUuqS34oI3Y7cHampDlr5JMlyg80j o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFFaCrgZ92P6s h1Te9WOiMjKYM/qMMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIg T3xV/U9iEuC8e9LCJ4sfohlUOT+nyBXceJ9JWsjElm0CIQDEx0/rFX1cLXK3wxB7 IhnqfINvER3n5HnOzJTb/oXTog== -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBjzCCATWgAwIBAgIUakyDv9YuXHQ/cC6FWmHrwXo629gwCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjExMTMxMzIz MzVaFw0zNjExMTAxMzIzMzVaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQg5GuSjmV0V0T8D8wYsec+ Qcfx85yB8bmlvn2CVih9B8QTuQo8ii9sPrlUUuqS34oI3Y7cHampDlr5JMlyg80j o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFFaCrgZ92P6s h1Te9WOiMjKYM/qMMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIg T3xV/U9iEuC8e9LCJ4sfohlUOT+nyBXceJ9JWsjElm0CIQDEx0/rFX1cLXK3wxB7 IhnqfINvER3n5HnOzJTb/oXTog== -----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.24 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 # [ 21.397121] tribuchet[899]: 2026-11-13T13:23:35.560059Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 21.400658] tribuchet[899]: 2026-11-13T13:23:35.564004Z 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.896795] tribuchet[918]: 2026-11-13T13:23:34.253435Z 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/phdyav1y3bi1w70knhva14ifbbg24alw-qemu-user-static-x86_64-unknown-linux-musl-11.1.1/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.913870] tribuchet[918]: 2026-11-13T13:23:34.254202Z 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.02 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered' worker # [ 14.006309] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[933]: 2026-11-13T13:23:34.363254Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 14.009450] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[933]: 2026-11-13T13:23:34.363424Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 14.012196] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[933]: 2026-11-13T13:23:34.363451Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 14.014917] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[933]: 2026-11-13T13:23:34.364445Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 14.092339] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[941]: 2026-11-13T13:23:34.449282Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 14.096299] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[941]: 2026-11-13T13:23:34.449446Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 14.098843] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[941]: 2026-11-13T13:23:34.449474Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 14.101462] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[941]: 2026-11-13T13:23:34.450445Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 14.106513] tribuchet[918]: 2026-11-13T13:23:34.463794Z WARN tribuchet::worker: hub session ended: connecting to hub worker # [ 14.106983] tribuchet[918]: 2026-11-13T13:23:34.463844Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 22.699510] tribuchet[899]: 2026-11-13T13:23:36.862244Z 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 # [ 15.157227] tribuchet[918]: 2026-11-13T13:23:35.513847Z 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 2.15 seconds) ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-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/ia9s7i2873j5j7hl958fm47b38lcaf4i-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 2.39 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 # [ 24.057861] systemd[935]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 24.156718] systemd[935]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 16.835081] systemd[965]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 16.914921] systemd[965]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 25.275364] tribuchet[899]: 2026-11-13T13:23:39.438303Z INFO tribuchet::hub::submit: queueing build id="87037c38d03b8ac09b4f72330320d0e1" system="x86_64-linux" hub # [ 25.278071] tribuchet[899]: 2026-11-13T13:23:39.441280Z INFO tribuchet::hub: dispatching build id="87037c38d03b8ac09b4f72330320d0e1" worker="worker" worker # [ 17.700572] tribuchet[918]: 2026-11-13T13:23:38.057083Z INFO tribuchet::worker::session: build assigned id="87037c38d03b8ac09b4f72330320d0e1" worker # [ 17.775357] nix-daemon[983]: accepted connection from pid 918, user tribuchet (trusted) hub # [ 25.367639] tribuchet[899]: 2026-11-13T13:23:39.530782Z INFO tribuchet::hub::relay::staging: input path negotiation done id="87037c38d03b8ac09b4f72330320d0e1" total=8 missing=1 hub # [ 25.444769] nix-daemon[1000]: accepted connection from pid 899, user root (trusted) worker # [ 17.877489] nix-daemon[983]: accepted connection from pid 918, user tribuchet (trusted) worker # [ 17.891817] tribuchet[918]: 2026-11-13T13:23:38.248982Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="87037c38d03b8ac09b4f72330320d0e1" fixed_output=false network=false net_isolation=false worker # [ 18.021100] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[994]: 2026-11-13T13:23:38.377926Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 18.027781] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[994]: 2026-11-13T13:23:38.378784Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 18.033845] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[994]: 2026-11-13T13:23:38.378858Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 18.039278] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[994]: 2026-11-13T13:23:38.396127Z INFO tribuchet::worker::agent: builder started id="87037c38d03b8ac09b4f72330320d0e1" pid=1000 worker # [ 18.045882] tribuchet[918]: 2026-11-13T13:23:38.396204Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="87037c38d03b8ac09b4f72330320d0e1" pid=1000 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/5bdc40038fbbf1c0/build worker # [ 18.060111] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[994]: 2026-11-13T13:23:38.417300Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=21 cpu_usec=7992 peak_memory_bytes=1519616 worker # [ 18.239931] tribuchet[918]: 2026-11-13T13:23:38.596861Z INFO tribuchet::worker::build::agent_exec: builder finished id="87037c38d03b8ac09b4f72330320d0e1" exit_code=0 aborted=None worker # [ 18.267104] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[994]: 2026-11-13T13:23:38.623430Z INFO tribuchet::worker::agent: cleanup done id="87037c38d03b8ac09b4f72330320d0e1" worker # [ 18.421348] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1015]: 2026-11-13T13:23:38.778104Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 18.426944] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1015]: 2026-11-13T13:23:38.784087Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 18.431707] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1015]: 2026-11-13T13:23:38.784159Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 18.435908] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1015]: 2026-11-13T13:23:38.784248Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 18.449392] tribuchet[918]: 2026-11-13T13:23:38.804958Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="87037c38d03b8ac09b4f72330320d0e1" hub # [ 26.031179] tribuchet[899]: 2026-11-13T13:23:40.194128Z INFO tribuchet::hub::relay: build usage id="87037c38d03b8ac09b4f72330320d0e1" key="2556de5e8b63646eea80f26d646fd9ef83ea4c5643e4280fad9aefb1e78f7cc4" exit_code=0 wall_ms=21 cpu_usec=7992 peak_memory_bytes=1519616 oom_killed=false worker # [ 18.462514] tribuchet[918]: 2026-11-13T13:23:38.819813Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="87037c38d03b8ac09b4f72330320d0e1" hub # [ 26.451799] tribuchet[899]: 2026-11-13T13:23:40.614350Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 18.871881] tribuchet[918]: 2026-11-13T13:23:39.227830Z 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 # [ 18.882922] tribuchet[918]: 2026-11-13T13:23:39.228009Z INFO tribuchet::worker: reconnecting to hub in 2s hub # [ 26.471265] nix-daemon[1000]: reaped child process 1002, status = succeeded hub # [ 26.486324] tribuchet[1028]: 2026-11-13T13:23:40.649061Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 26.488429] tribuchet[1028]: 2026-11-13T13:23:40.649234Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 27.309261] tribuchet[1028]: 2026-11-13T13:23:41.472613Z INFO tribuchet::hub::submit: no capable worker yet; waiting system="x86_64-linux" hub # [ 28.461564] tribuchet[1028]: 2026-11-13T13:23:42.624137Z 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 # [ 28.472565] tribuchet[1028]: 2026-11-13T13:23:42.635209Z INFO tribuchet::hub::submit: queueing build id="77800541336afe6cde6c06b69592d826" system="x86_64-linux" worker # [ 20.921779] tribuchet[918]: 2026-11-13T13:23:41.277819Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 28.509194] tribuchet[1028]: 2026-11-13T13:23:42.671952Z INFO tribuchet::hub: dispatching build id="77800541336afe6cde6c06b69592d826" worker="worker" worker # [ 20.928598] tribuchet[918]: 2026-11-13T13:23:41.284672Z INFO tribuchet::worker::session: build assigned id="77800541336afe6cde6c06b69592d826" worker # [ 20.934275] nix-daemon[983]: accepted connection from pid 918, user tribuchet (trusted) hub # [ 28.525280] tribuchet[1028]: 2026-11-13T13:23:42.688517Z INFO tribuchet::hub::relay::staging: input path negotiation done id="77800541336afe6cde6c06b69592d826" total=7 missing=0 worker # [ 20.943117] tribuchet[918]: 2026-11-13T13:23:41.300293Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="77800541336afe6cde6c06b69592d826" fixed_output=false network=false net_isolation=false worker # [ 21.070657] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:23:41.427194Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 21.077708] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:23:41.434959Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 21.079178] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:23:41.435039Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 21.108146] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:23:41.465423Z INFO tribuchet::worker::agent: builder started id="77800541336afe6cde6c06b69592d826" pid=1071 worker # [ 21.116333] tribuchet[918]: 2026-11-13T13:23:41.465509Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="77800541336afe6cde6c06b69592d826" pid=1071 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/055e88dde96f9797/build worker # [ 21.384771] tribuchet[918]: 2026-11-13T13:23:41.741267Z INFO tribuchet::worker: handover requested; exiting hub # [ 28.968254] tribuchet[1028]: 2026-11-13T13:23:43.131027Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 28.972955] tribuchet[1028]: 2026-11-13T13:23:43.131122Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="77800541336afe6cde6c06b69592d826" worker # [ 21.428037] tribuchet[1097]: 2026-11-13T13:23:41.785012Z 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/phdyav1y3bi1w70knhva14ifbbg24alw-qemu-user-static-x86_64-unknown-linux-musl-11.1.1/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 # [ 21.438207] tribuchet[1097]: 2026-11-13T13:23:41.785446Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 21.453059] tribuchet[1097]: 2026-11-13T13:23:41.809501Z INFO tribuchet::worker::resume: adopted running build id="77800541336afe6cde6c06b69592d826" pid=1071 worker # [ 21.461804] nix-daemon[983]: accepted connection from pid 1097, user tribuchet (trusted) worker # [ 21.527540] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1113]: 2026-11-13T13:23:41.884590Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 21.527704] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1113]: 2026-11-13T13:23:41.884734Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 21.528219] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1113]: 2026-11-13T13:23:41.884762Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 21.535048] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1113]: 2026-11-13T13:23:41.892359Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 21.543840] tribuchet[1097]: 2026-11-13T13:23:41.901155Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 29.126133] tribuchet[1028]: 2026-11-13T13:23:43.288640Z 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 # [ 21.546925] tribuchet[1097]: 2026-11-13T13:23:41.904258Z INFO tribuchet::worker::session: build resumed id="77800541336afe6cde6c06b69592d826" key="377d4f8123e740edf7f3cf41d5dfc19f2c9c5c20c7300c98c76280fabc29fab8" hub # [ 29.130341] tribuchet[1028]: 2026-11-13T13:23:43.288741Z INFO tribuchet::hub: dispatching build id="77800541336afe6cde6c06b69592d826" worker="worker" hub # [ 29.134572] tribuchet[1028]: 2026-11-13T13:23:43.297856Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="77800541336afe6cde6c06b69592d826" hub # [ 29.199823] tribuchet[1028]: 2026-11-13T13:23:43.360345Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 21.615983] tribuchet[1097]: 2026-11-13T13:23:41.973247Z 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 # [ 21.616220] tribuchet[1097]: 2026-11-13T13:23:41.973345Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 29.228406] tribuchet[1089]: 2026-11-13T13:23:43.390771Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 29.230758] tribuchet[1089]: 2026-11-13T13:23:43.390940Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 30.206486] tribuchet[1089]: 2026-11-13T13:23:44.369532Z 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 # [ 22.667572] tribuchet[1097]: 2026-11-13T13:23:43.023351Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 31.200840] tribuchet[1089]: 2026-11-13T13:23:45.362776Z INFO tribuchet::hub::submit: queueing build id="c94fbe2181701956ae5c70ba0ceec86d" system="x86_64-linux" worker # [ 23.619078] tribuchet[1097]: 2026-11-13T13:23:43.976200Z INFO tribuchet::worker::session: build resumed id="c94fbe2181701956ae5c70ba0ceec86d" key="377d4f8123e740edf7f3cf41d5dfc19f2c9c5c20c7300c98c76280fabc29fab8" hub # [ 31.207233] tribuchet[1089]: 2026-11-13T13:23:45.362900Z INFO tribuchet::hub: dispatching build id="c94fbe2181701956ae5c70ba0ceec86d" worker="worker" hub # [ 31.214124] tribuchet[1089]: 2026-11-13T13:23:45.377301Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="c94fbe2181701956ae5c70ba0ceec86d" worker # [ 40.650586] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:24:01.007151Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=19541 cpu_usec=19161998 peak_memory_bytes=1011712 worker # [ 40.654219] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:24:01.007667Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 40.702819] tribuchet[1097]: 2026-11-13T13:24:01.059653Z INFO tribuchet::worker::build::agent_exec: builder finished id="77800541336afe6cde6c06b69592d826" exit_code=0 aborted=None worker # [ 40.719631] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1064]: 2026-11-13T13:24:01.076924Z INFO tribuchet::worker::agent: cleanup done id="77800541336afe6cde6c06b69592d826" worker # [ 40.849583] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1140]: 2026-11-13T13:24:01.206143Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 40.856684] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1140]: 2026-11-13T13:24:01.208504Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 40.862767] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1140]: 2026-11-13T13:24:01.208557Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 40.868377] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1140]: 2026-11-13T13:24:01.208637Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 40.873306] tribuchet[1097]: 2026-11-13T13:24:01.230336Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="c94fbe2181701956ae5c70ba0ceec86d" hub # [ 48.456749] tribuchet[1089]: 2026-11-13T13:24:02.619128Z INFO tribuchet::hub::relay: build usage id="c94fbe2181701956ae5c70ba0ceec86d" key="377d4f8123e740edf7f3cf41d5dfc19f2c9c5c20c7300c98c76280fabc29fab8" exit_code=0 wall_ms=19541 cpu_usec=19161998 peak_memory_bytes=1011712 oom_killed=false worker # [ 40.888315] tribuchet[1097]: 2026-11-13T13:24:01.245591Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="c94fbe2181701956ae5c70ba0ceec86d" worker # [ 41.906237] systemd[1152]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 41.978913] systemd[1152]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 50.044508] tribuchet[1089]: 2026-11-13T13:24:04.207520Z INFO tribuchet::hub::submit: queueing build id="0778b105f508d9c3a2a16318a97b36f1" system="x86_64-linux" hub # [ 50.047675] tribuchet[1089]: 2026-11-13T13:24:04.210472Z INFO tribuchet::hub: dispatching build id="0778b105f508d9c3a2a16318a97b36f1" worker="worker" worker # [ 42.467416] tribuchet[1097]: 2026-11-13T13:24:02.823878Z INFO tribuchet::worker::session: build assigned id="0778b105f508d9c3a2a16318a97b36f1" worker # [ 42.475895] nix-daemon[983]: accepted connection from pid 1097, user tribuchet (trusted) hub # [ 50.068190] tribuchet[1089]: 2026-11-13T13:24:04.231505Z INFO tribuchet::hub::relay::staging: input path negotiation done id="0778b105f508d9c3a2a16318a97b36f1" total=7 missing=0 worker # [ 42.486915] tribuchet[1097]: 2026-11-13T13:24:02.843892Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="0778b105f508d9c3a2a16318a97b36f1" fixed_output=false network=false net_isolation=false worker # [ 42.625763] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1175]: 2026-11-13T13:24:02.982063Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 42.632984] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1175]: 2026-11-13T13:24:02.982274Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 42.645164] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1175]: 2026-11-13T13:24:02.982333Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 42.645280] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1175]: 2026-11-13T13:24:02.989718Z INFO tribuchet::worker::agent: builder started id="0778b105f508d9c3a2a16318a97b36f1" pid=1181 worker # [ 42.646085] tribuchet[1097]: 2026-11-13T13:24:02.991009Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="0778b105f508d9c3a2a16318a97b36f1" pid=1181 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/a8179f100e49870a/build [e2e] heartbeat t=30s worker # [ 61.648372] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1175]: 2026-11-13T13:24:22.004964Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=19015 cpu_usec=18680761 peak_memory_bytes=1044480 worker # [ 61.664159] tribuchet[1097]: 2026-11-13T13:24:22.021175Z INFO tribuchet::worker::build::agent_exec: builder finished id="0778b105f508d9c3a2a16318a97b36f1" exit_code=0 aborted=None worker # [ 61.685701] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1175]: 2026-11-13T13:24:22.042975Z INFO tribuchet::worker::agent: cleanup done id="0778b105f508d9c3a2a16318a97b36f1" worker # [ 61.796904] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1201]: 2026-11-13T13:24:22.153026Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 61.797682] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1201]: 2026-11-13T13:24:22.153258Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 61.799182] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1201]: 2026-11-13T13:24:22.153305Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 61.800105] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1201]: 2026-11-13T13:24:22.153428Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 61.880603] tribuchet[1097]: 2026-11-13T13:24:22.236845Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="0778b105f508d9c3a2a16318a97b36f1" hub # [ 69.464110] tribuchet[1089]: 2026-11-13T13:24:23.625098Z INFO tribuchet::hub::relay: build usage id="0778b105f508d9c3a2a16318a97b36f1" key="824de5db982082488def6827fb432e0f66e5035702763a8071890117ca40e37e" exit_code=0 wall_ms=19015 cpu_usec=18680761 peak_memory_bytes=1044480 oom_killed=false worker # [ 61.895743] tribuchet[1097]: 2026-11-13T13:24:22.252944Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="0778b105f508d9c3a2a16318a97b36f1" worker # [ 62.198825] systemd[1214]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 62.267891] systemd[1214]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 70.187651] tribuchet[1089]: 2026-11-13T13:24:24.350673Z INFO tribuchet::hub::submit: queueing build id="643f66dc3023dcca326693b227b14dcc" system="x86_64-linux" hub # [ 70.190281] tribuchet[1089]: 2026-11-13T13:24:24.350728Z INFO tribuchet::hub: dispatching build id="643f66dc3023dcca326693b227b14dcc" worker="worker" worker # [ 62.606486] tribuchet[1097]: 2026-11-13T13:24:22.963719Z INFO tribuchet::worker::session: build assigned id="643f66dc3023dcca326693b227b14dcc" worker # [ 62.618422] nix-daemon[983]: accepted connection from pid 1097, user tribuchet (trusted) hub # [ 70.213224] tribuchet[1089]: 2026-11-13T13:24:24.376491Z INFO tribuchet::hub::relay::staging: input path negotiation done id="643f66dc3023dcca326693b227b14dcc" total=7 missing=0 worker # [ 62.630078] tribuchet[1097]: 2026-11-13T13:24:22.987034Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="643f66dc3023dcca326693b227b14dcc" fixed_output=false network=false net_isolation=false worker # [ 62.740236] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:23.097236Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 62.743237] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:23.100555Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 62.743617] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:23.100591Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 62.761071] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:23.118075Z INFO tribuchet::worker::agent: builder started id="643f66dc3023dcca326693b227b14dcc" pid=1259 worker # [ 62.761605] tribuchet[1097]: 2026-11-13T13:24:23.118141Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="643f66dc3023dcca326693b227b14dcc" pid=1259 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/db99aaaa3a2b8c10/build worker # [ 62.837670] tribuchet[1097]: 2026-11-13T13:24:23.194990Z INFO tribuchet::worker: handover requested; exiting hub # [ 70.424628] tribuchet[1089]: 2026-11-13T13:24:24.587590Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 70.429578] tribuchet[1089]: 2026-11-13T13:24:24.587673Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="643f66dc3023dcca326693b227b14dcc" worker # [ 62.877456] tribuchet[1273]: 2026-11-13T13:24:23.234536Z 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/phdyav1y3bi1w70knhva14ifbbg24alw-qemu-user-static-x86_64-unknown-linux-musl-11.1.1/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 # [ 62.889679] tribuchet[1273]: 2026-11-13T13:24:23.235021Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 62.897681] tribuchet[1273]: 2026-11-13T13:24:23.246336Z INFO tribuchet::worker::resume: adopted running build id="643f66dc3023dcca326693b227b14dcc" pid=1259 worker # [ 62.905787] nix-daemon[983]: accepted connection from pid 1273, user tribuchet (trusted) worker # [ 62.975797] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1289]: 2026-11-13T13:24:23.332922Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 62.979073] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1289]: 2026-11-13T13:24:23.336408Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 62.981694] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1289]: 2026-11-13T13:24:23.339034Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 62.984248] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1289]: 2026-11-13T13:24:23.341591Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 62.994058] tribuchet[1273]: 2026-11-13T13:24:23.351302Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 62.997291] tribuchet[1273]: 2026-11-13T13:24:23.354606Z INFO tribuchet::worker::session: build resumed id="643f66dc3023dcca326693b227b14dcc" key="1ddf3bbc5a3d3cad8f2bffb2f1773743fa04b4ea844d1ed444c8a42aa9164681" hub # [ 70.576665] tribuchet[1089]: 2026-11-13T13:24:24.738649Z 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 # [ 70.590490] tribuchet[1089]: 2026-11-13T13:24:24.738815Z INFO tribuchet::hub: dispatching build id="643f66dc3023dcca326693b227b14dcc" worker="worker" hub # [ 70.597097] tribuchet[1089]: 2026-11-13T13:24:24.759975Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="643f66dc3023dcca326693b227b14dcc" [e2e] heartbeat t=60s worker # [ 77.737737] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:38.092957Z INFO tribuchet::worker::agent: builder exited code=137 wall_ms=14974 cpu_usec=14691092 peak_memory_bytes=20803584 worker # [ 77.745777] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:38.093077Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 77.947937] tribuchet[1273]: 2026-11-13T13:24:38.304371Z INFO tribuchet::worker::build::agent_exec: builder finished id="643f66dc3023dcca326693b227b14dcc" exit_code=137 aborted=Some("build log exceeded the limit of 1048576 bytes") worker # [ 77.962897] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1251]: 2026-11-13T13:24:38.319340Z INFO tribuchet::worker::agent: cleanup done id="643f66dc3023dcca326693b227b14dcc" worker # [ 78.110794] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1307]: 2026-11-13T13:24:38.466786Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 78.114400] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1307]: 2026-11-13T13:24:38.466989Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 78.114978] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1307]: 2026-11-13T13:24:38.467045Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 78.115766] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1307]: 2026-11-13T13:24:38.467135Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 78.208486] tribuchet[1273]: 2026-11-13T13:24:38.565501Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="643f66dc3023dcca326693b227b14dcc" hub # [ 85.792307] tribuchet[1089]: 2026-11-13T13:24:39.954496Z INFO tribuchet::hub::relay: build usage id="643f66dc3023dcca326693b227b14dcc" key="1ddf3bbc5a3d3cad8f2bffb2f1773743fa04b4ea844d1ed444c8a42aa9164681" exit_code=1 wall_ms=14974 cpu_usec=14691092 peak_memory_bytes=20803584 oom_killed=false worker # [ 78.222885] tribuchet[1273]: 2026-11-13T13:24:38.580127Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="643f66dc3023dcca326693b227b14dcc" hub # [ 85.832169] systemd[1]: slowlogbuild.service: Main process exited, code=exited, status=100/n/a hub # [ 85.836352] systemd[1]: slowlogbuild.service: Failed with result 'exit-code'. worker # [ 78.757534] systemd[1319]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 78.848865] systemd[1319]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 87.030196] tribuchet[1089]: 2026-11-13T13:24:41.192927Z INFO tribuchet::hub::submit: queueing build id="6596432f72cfc76042bb794ffc3f25b3" system="x86_64-linux" hub # [ 87.032778] tribuchet[1089]: 2026-11-13T13:24:41.192973Z INFO tribuchet::hub: dispatching build id="6596432f72cfc76042bb794ffc3f25b3" worker="worker" worker # [ 79.449860] tribuchet[1273]: 2026-11-13T13:24:39.806536Z INFO tribuchet::worker::session: build assigned id="6596432f72cfc76042bb794ffc3f25b3" worker # [ 79.461260] nix-daemon[983]: accepted connection from pid 1273, user tribuchet (trusted) hub # [ 87.056323] tribuchet[1089]: 2026-11-13T13:24:41.219636Z INFO tribuchet::hub::relay::staging: input path negotiation done id="6596432f72cfc76042bb794ffc3f25b3" total=7 missing=0 worker # [ 79.475171] tribuchet[1273]: 2026-11-13T13:24:39.832221Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="6596432f72cfc76042bb794ffc3f25b3" fixed_output=false network=false net_isolation=false worker # [ 79.568065] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:39.925124Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 79.570900] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:39.925811Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 79.573462] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:39.925845Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 79.577348] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:39.934682Z INFO tribuchet::worker::agent: builder started id="6596432f72cfc76042bb794ffc3f25b3" pid=1375 worker # [ 79.580406] tribuchet[1273]: 2026-11-13T13:24:39.937656Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="6596432f72cfc76042bb794ffc3f25b3" pid=1375 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/98af181d32ceeb80/build worker # [ 79.768589] tribuchet[1273]: 2026-11-13T13:24:40.125905Z INFO tribuchet::worker: handover requested; exiting hub # [ 87.354700] tribuchet[1089]: 2026-11-13T13:24:41.517841Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 87.359963] tribuchet[1089]: 2026-11-13T13:24:41.522680Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="6596432f72cfc76042bb794ffc3f25b3" worker # [ 79.804051] tribuchet[1401]: 2026-11-13T13:24:40.161135Z 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/phdyav1y3bi1w70knhva14ifbbg24alw-qemu-user-static-x86_64-unknown-linux-musl-11.1.1/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 # [ 79.815673] tribuchet[1401]: 2026-11-13T13:24:40.161570Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 79.818948] tribuchet[1401]: 2026-11-13T13:24:40.172761Z INFO tribuchet::worker::resume: adopted running build id="6596432f72cfc76042bb794ffc3f25b3" pid=1375 worker # [ 79.825901] nix-daemon[983]: accepted connection from pid 1401, user tribuchet (trusted) worker # [ 79.893911] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1417]: 2026-11-13T13:24:40.251033Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 79.897062] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1417]: 2026-11-13T13:24:40.254398Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 79.901756] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1417]: 2026-11-13T13:24:40.256875Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 79.905763] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1417]: 2026-11-13T13:24:40.256984Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 79.915611] tribuchet[1401]: 2026-11-13T13:24:40.272690Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 79.918614] tribuchet[1401]: 2026-11-13T13:24:40.275935Z INFO tribuchet::worker::session: build resumed id="6596432f72cfc76042bb794ffc3f25b3" key="1bc018cbea63450d03533651b04498d3acc9a44928352861cc3086b0a65980cb" hub # [ 87.498090] tribuchet[1089]: 2026-11-13T13:24:41.660041Z 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 # [ 87.508593] tribuchet[1089]: 2026-11-13T13:24:41.660196Z INFO tribuchet::hub: dispatching build id="6596432f72cfc76042bb794ffc3f25b3" worker="worker" hub # [ 87.517745] tribuchet[1089]: 2026-11-13T13:24:41.679769Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="6596432f72cfc76042bb794ffc3f25b3" worker # [ 93.648560] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:54.005285Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14070 cpu_usec=13806475 peak_memory_bytes=1409024 worker # [ 93.648740] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:54.005850Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 93.661801] tribuchet[1401]: 2026-11-13T13:24:54.018773Z INFO tribuchet::worker::build::agent_exec: builder finished id="6596432f72cfc76042bb794ffc3f25b3" exit_code=0 aborted=None worker # [ 93.674659] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1369]: 2026-11-13T13:24:54.031962Z INFO tribuchet::worker::agent: cleanup done id="6596432f72cfc76042bb794ffc3f25b3" worker # [ 93.797156] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1437]: 2026-11-13T13:24:54.154140Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 93.800948] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1437]: 2026-11-13T13:24:54.158261Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 93.801393] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1437]: 2026-11-13T13:24:54.158320Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 93.809776] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1437]: 2026-11-13T13:24:54.166903Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 93.862204] tribuchet[1401]: 2026-11-13T13:24:54.219488Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="6596432f72cfc76042bb794ffc3f25b3" hub # [ 101.444932] tribuchet[1089]: 2026-11-13T13:24:55.607925Z INFO tribuchet::hub::relay: build usage id="6596432f72cfc76042bb794ffc3f25b3" key="1bc018cbea63450d03533651b04498d3acc9a44928352861cc3086b0a65980cb" exit_code=0 wall_ms=14070 cpu_usec=13806475 peak_memory_bytes=1409024 oom_killed=false worker # [ 93.868376] tribuchet[1401]: 2026-11-13T13:24:54.225640Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="6596432f72cfc76042bb794ffc3f25b3" worker # [ 95.267943] systemd[1449]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 95.337774] systemd[1449]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 103.666348] tribuchet[1089]: 2026-11-13T13:24:57.829137Z INFO tribuchet::hub::submit: queueing build id="960deff4927bf2ab7a536dd5321fb970" system="x86_64-linux" hub # [ 103.669190] tribuchet[1089]: 2026-11-13T13:24:57.829184Z INFO tribuchet::hub: dispatching build id="960deff4927bf2ab7a536dd5321fb970" worker="worker" worker # [ 96.087313] tribuchet[1401]: 2026-11-13T13:24:56.443541Z INFO tribuchet::worker::session: build assigned id="960deff4927bf2ab7a536dd5321fb970" worker # [ 96.099751] nix-daemon[983]: accepted connection from pid 1401, user tribuchet (trusted) hub # [ 103.692537] tribuchet[1089]: 2026-11-13T13:24:57.855806Z INFO tribuchet::hub::relay::staging: input path negotiation done id="960deff4927bf2ab7a536dd5321fb970" total=7 missing=0 worker # [ 96.110921] tribuchet[1401]: 2026-11-13T13:24:56.468157Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="960deff4927bf2ab7a536dd5321fb970" fixed_output=false network=false net_isolation=false worker # [ 96.197945] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1495]: 2026-11-13T13:24:56.555070Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 96.201044] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1495]: 2026-11-13T13:24:56.558338Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 96.201417] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1495]: 2026-11-13T13:24:56.558393Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 96.213498] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1495]: 2026-11-13T13:24:56.570813Z INFO tribuchet::worker::agent: builder started id="960deff4927bf2ab7a536dd5321fb970" pid=1503 worker # [ 96.213905] tribuchet[1401]: 2026-11-13T13:24:56.570871Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="960deff4927bf2ab7a536dd5321fb970" pid=1503 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/4f394d3bc1635767/build hub # [ 104.653696] systemd[1]: cancelbuild.service: Main process exited, code=killed, status=9/KILL hub # [ 104.656363] systemd[1]: cancelbuild.service: Failed with result 'signal'. [e2e] heartbeat t=90s worker # [ 108.086567] tribuchet[1401]: 2026-11-13T13:25:08.443080Z INFO tribuchet::worker::session: hub cancelled the build id="960deff4927bf2ab7a536dd5321fb970" hub # [ 115.667861] tribuchet[1089]: 2026-11-13T13:25:09.830045Z INFO tribuchet::hub::relay: no attach client left; cancelling build id="960deff4927bf2ab7a536dd5321fb970" worker # [ 108.242460] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1495]: 2026-11-13T13:25:08.599041Z INFO tribuchet::worker::agent: builder exited code=137 wall_ms=12028 cpu_usec=11769405 peak_memory_bytes=1040384 worker # [ 108.448672] tribuchet[1401]: 2026-11-13T13:25:08.805905Z INFO tribuchet::worker::build::agent_exec: builder finished id="960deff4927bf2ab7a536dd5321fb970" exit_code=137 aborted=Some("build cancelled") worker # [ 108.469253] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1495]: 2026-11-13T13:25:08.825313Z INFO tribuchet::worker::agent: cleanup done id="960deff4927bf2ab7a536dd5321fb970" worker # [ 108.564052] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1713]: 2026-11-13T13:25:08.921117Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 108.567357] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1713]: 2026-11-13T13:25:08.921779Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 108.569950] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1713]: 2026-11-13T13:25:08.921855Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 108.572286] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1713]: 2026-11-13T13:25:08.921896Z INFO tribuchet::worker::agent: no build held, exiting until the next activation hub # [ 116.238826] tribuchet[1089]: 2026-11-13T13:25:10.402012Z INFO tribuchet::hub::relay: build usage id="960deff4927bf2ab7a536dd5321fb970" key="7202846d83769dd6e209fd70f1664e0b721c99e399e3921dda2d161801db64e2" exit_code=1 wall_ms=12028 cpu_usec=11769405 peak_memory_bytes=1040384 oom_killed=false worker # [ 108.656605] tribuchet[1401]: 2026-11-13T13:25:09.013820Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="960deff4927bf2ab7a536dd5321fb970" worker # [ 108.661533] tribuchet[1401]: 2026-11-13T13:25:09.018301Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="960deff4927bf2ab7a536dd5321fb970" hub # [ 116.375238] systemd[2009]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 116.456679] systemd[2009]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 116.729448] tribuchet[1089]: 2026-11-13T13:25:10.892320Z INFO tribuchet::hub::submit: queueing build id="bd5a8bc73fe89c8c6030b2b0495882fa" system="x86_64-linux" hub # [ 116.732418] tribuchet[1089]: 2026-11-13T13:25:10.892381Z INFO tribuchet::hub: dispatching build id="bd5a8bc73fe89c8c6030b2b0495882fa" worker="worker" worker # [ 109.152402] tribuchet[1401]: 2026-11-13T13:25:09.508745Z INFO tribuchet::worker::session: build assigned id="bd5a8bc73fe89c8c6030b2b0495882fa" worker # [ 109.158217] nix-daemon[983]: accepted connection from pid 1401, user tribuchet (trusted) hub # [ 116.748495] tribuchet[1089]: 2026-11-13T13:25:10.911744Z INFO tribuchet::hub::relay::staging: input path negotiation done id="bd5a8bc73fe89c8c6030b2b0495882fa" total=7 missing=0 worker # [ 109.166602] tribuchet[1401]: 2026-11-13T13:25:09.523842Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="bd5a8bc73fe89c8c6030b2b0495882fa" fixed_output=false network=false net_isolation=false worker # [ 109.309844] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1724]: 2026-11-13T13:25:09.666137Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 109.310965] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1724]: 2026-11-13T13:25:09.666454Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 109.312501] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1724]: 2026-11-13T13:25:09.666514Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 109.343723] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1724]: 2026-11-13T13:25:09.700939Z INFO tribuchet::worker::agent: builder started id="bd5a8bc73fe89c8c6030b2b0495882fa" pid=1730 worker # [ 109.345259] tribuchet[1401]: 2026-11-13T13:25:09.702531Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="bd5a8bc73fe89c8c6030b2b0495882fa" pid=1730 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/c894e01a8950ab73/build [e2e] heartbeat t=120s worker # [ 138.651235] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1724]: 2026-11-13T13:25:39.008022Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=29307 cpu_usec=28833710 peak_memory_bytes=1019904 worker # [ 138.796381] tribuchet[1401]: 2026-11-13T13:25:39.152997Z INFO tribuchet::worker::build::agent_exec: builder finished id="bd5a8bc73fe89c8c6030b2b0495882fa" exit_code=0 aborted=None worker # [ 138.828177] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1724]: 2026-11-13T13:25:39.185272Z INFO tribuchet::worker::agent: cleanup done id="bd5a8bc73fe89c8c6030b2b0495882fa" worker # [ 138.937228] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1749]: 2026-11-13T13:25:39.293897Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 138.944548] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1749]: 2026-11-13T13:25:39.295469Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 138.951649] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1749]: 2026-11-13T13:25:39.295513Z INFO tribuchet::worker::agent: agent listening uid=61629 hub # [ 146.529407] tribuchet[1089]: 2026-11-13T13:25:40.691013Z INFO tribuchet::hub::relay: build usage id="bd5a8bc73fe89c8c6030b2b0495882fa" key="7202846d83769dd6e209fd70f1664e0b721c99e399e3921dda2d161801db64e2" exit_code=0 wall_ms=29307 cpu_usec=28833710 peak_memory_bytes=1019904 oom_killed=false worker # [ 138.957094] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1749]: 2026-11-13T13:25:39.295603Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 138.962955] tribuchet[1401]: 2026-11-13T13:25:39.302657Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="bd5a8bc73fe89c8c6030b2b0495882fa" worker # [ 138.968146] tribuchet[1401]: 2026-11-13T13:25:39.305830Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="bd5a8bc73fe89c8c6030b2b0495882fa" hub # [ 146.870282] tribuchet[1089]: 2026-11-13T13:25:41.033076Z INFO tribuchet::hub::submit: queueing build id="7629b781883b929897a9d5d8c3ce2643" system="x86_64-linux" hub # [ 146.873341] tribuchet[1089]: 2026-11-13T13:25:41.033124Z INFO tribuchet::hub: dispatching build id="7629b781883b929897a9d5d8c3ce2643" worker="worker" worker # [ 139.289184] tribuchet[1401]: 2026-11-13T13:25:39.646305Z INFO tribuchet::worker::session: build assigned id="7629b781883b929897a9d5d8c3ce2643" worker # [ 139.298383] nix-daemon[983]: accepted connection from pid 1401, user tribuchet (trusted) hub # [ 146.889055] tribuchet[1089]: 2026-11-13T13:25:41.052164Z INFO tribuchet::hub::submit: queueing build id="ca8282f717356a9aae10d621ae23de7e" system="x86_64-linux" hub # [ 146.891647] tribuchet[1089]: 2026-11-13T13:25:41.052200Z INFO tribuchet::hub: dispatching build id="ca8282f717356a9aae10d621ae23de7e" worker="worker" worker # [ 139.309476] tribuchet[1401]: 2026-11-13T13:25:39.666429Z INFO tribuchet::worker::session: build assigned id="ca8282f717356a9aae10d621ae23de7e" hub # [ 146.894077] tribuchet[1089]: 2026-11-13T13:25:41.057422Z INFO tribuchet::hub::relay::staging: input path negotiation done id="7629b781883b929897a9d5d8c3ce2643" total=7 missing=0 worker # [ 139.310571] tribuchet[1401]: 2026-11-13T13:25:39.666853Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="7629b781883b929897a9d5d8c3ce2643" fixed_output=false network=false net_isolation=false worker # [ 139.326735] nix-daemon[983]: accepted connection from pid 1401, user tribuchet (trusted) hub # [ 146.921265] tribuchet[1089]: 2026-11-13T13:25:41.084482Z INFO tribuchet::hub::relay::staging: input path negotiation done id="ca8282f717356a9aae10d621ae23de7e" total=7 missing=0 worker # [ 139.340314] tribuchet[1401]: 2026-11-13T13:25:39.696888Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="ca8282f717356a9aae10d621ae23de7e" fixed_output=false network=false net_isolation=false worker # [ 139.438445] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1768]: 2026-11-13T13:25:39.795521Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 139.438632] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1768]: 2026-11-13T13:25:39.795844Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 139.439340] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1766]: 2026-11-13T13:25:39.796497Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 139.446651] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1768]: 2026-11-13T13:25:39.803973Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 139.447148] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1766]: 2026-11-13T13:25:39.804487Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 139.447993] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1766]: 2026-11-13T13:25:39.805218Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 139.463530] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1766]: 2026-11-13T13:25:39.820839Z INFO tribuchet::worker::agent: builder started id="7629b781883b929897a9d5d8c3ce2643" pid=1779 worker # [ 139.465424] tribuchet[1401]: 2026-11-13T13:25:39.821226Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="7629b781883b929897a9d5d8c3ce2643" pid=1779 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/17157b66e5de949e/build worker # [ 139.471656] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1768]: 2026-11-13T13:25:39.828972Z INFO tribuchet::worker::agent: builder started id="ca8282f717356a9aae10d621ae23de7e" pid=1784 worker # [ 139.471962] tribuchet[1401]: 2026-11-13T13:25:39.829032Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="ca8282f717356a9aae10d621ae23de7e" pid=1784 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/a9a09f5eb84fb557/build worker # [ 153.650082] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1766]: 2026-11-13T13:25:54.007025Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14186 cpu_usec=13952933 peak_memory_bytes=1007616 worker # [ 153.655223] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1768]: 2026-11-13T13:25:54.012146Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=14183 cpu_usec=13924620 peak_memory_bytes=1011712 worker # [ 153.673785] tribuchet[1401]: 2026-11-13T13:25:54.030723Z INFO tribuchet::worker::build::agent_exec: builder finished id="7629b781883b929897a9d5d8c3ce2643" exit_code=0 aborted=None worker # [ 153.685690] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1766]: 2026-11-13T13:25:54.042513Z INFO tribuchet::worker::agent: cleanup done id="7629b781883b929897a9d5d8c3ce2643" worker # [ 153.688580] tribuchet[1401]: 2026-11-13T13:25:54.045867Z INFO tribuchet::worker::build::agent_exec: builder finished id="ca8282f717356a9aae10d621ae23de7e" exit_code=0 aborted=None worker # [ 153.705485] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1768]: 2026-11-13T13:25:54.062792Z INFO tribuchet::worker::agent: cleanup done id="ca8282f717356a9aae10d621ae23de7e" worker # [ 153.759281] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1808]: 2026-11-13T13:25:54.116405Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 153.762260] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1808]: 2026-11-13T13:25:54.119494Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 153.764851] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1808]: 2026-11-13T13:25:54.119537Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 153.767177] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1808]: 2026-11-13T13:25:54.119585Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 153.779088] tribuchet[1401]: 2026-11-13T13:25:54.135203Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="7629b781883b929897a9d5d8c3ce2643" hub # [ 161.361928] tribuchet[1089]: 2026-11-13T13:25:55.524248Z INFO tribuchet::hub::relay: build usage id="7629b781883b929897a9d5d8c3ce2643" key="3faad6839cbdb782b8c57e8dad333ceb25ce3ce163250712cdec6f997a6bd047" exit_code=0 wall_ms=14186 cpu_usec=13952933 peak_memory_bytes=1007616 oom_killed=false worker # [ 153.788227] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1810]: 2026-11-13T13:25:54.145228Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 153.790939] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1810]: 2026-11-13T13:25:54.148256Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 153.791520] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1810]: 2026-11-13T13:25:54.148294Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 153.795813] tribuchet[1401]: 2026-11-13T13:25:54.153128Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="7629b781883b929897a9d5d8c3ce2643" worker # [ 153.796170] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1810]: 2026-11-13T13:25:54.153202Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 153.892705] tribuchet[1401]: 2026-11-13T13:25:54.249914Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="ca8282f717356a9aae10d621ae23de7e" hub # [ 161.477724] tribuchet[1089]: 2026-11-13T13:25:55.640641Z INFO tribuchet::hub::relay: build usage id="ca8282f717356a9aae10d621ae23de7e" key="65d6dba4a04f141b705645a704627ef88f462a57625ba3a616899b55ef38dc6b" exit_code=0 wall_ms=14183 cpu_usec=13924620 peak_memory_bytes=1011712 oom_killed=false worker # [ 153.910340] tribuchet[1401]: 2026-11-13T13:25:54.267329Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="ca8282f717356a9aae10d621ae23de7e" worker # [ 154.295752] systemd[1825]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 154.364754] systemd[1825]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 162.561727] tribuchet[1089]: 2026-11-13T13:25:56.724421Z INFO tribuchet::hub::submit: queueing build id="81d3a5159b9d8238586911ef073deccc" system="x86_64-linux" hub # [ 162.564437] tribuchet[1089]: 2026-11-13T13:25:56.724468Z INFO tribuchet::hub: dispatching build id="81d3a5159b9d8238586911ef073deccc" worker="worker" worker # [ 154.980806] tribuchet[1401]: 2026-11-13T13:25:55.337447Z INFO tribuchet::worker::session: build assigned id="81d3a5159b9d8238586911ef073deccc" worker # [ 154.992507] nix-daemon[983]: accepted connection from pid 1401, user tribuchet (trusted) hub # [ 162.586581] tribuchet[1089]: 2026-11-13T13:25:56.749816Z INFO tribuchet::hub::relay::staging: input path negotiation done id="81d3a5159b9d8238586911ef073deccc" total=7 missing=0 worker # [ 155.008231] tribuchet[1401]: 2026-11-13T13:25:55.362058Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="81d3a5159b9d8238586911ef073deccc" fixed_output=false network=false net_isolation=false worker # [ 155.120301] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:25:55.477310Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 155.124254] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:25:55.477887Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 155.126846] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:25:55.477922Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 155.129729] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:25:55.487038Z INFO tribuchet::worker::agent: builder started id="81d3a5159b9d8238586911ef073deccc" pid=1878 worker # [ 155.132624] tribuchet[1401]: 2026-11-13T13:25:55.487094Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="81d3a5159b9d8238586911ef073deccc" pid=1878 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/d4b00354341bd423/build worker # [ 155.912048] tribuchet[1401]: 2026-11-13T13:25:56.269080Z INFO tribuchet::worker: handover requested; exiting hub # [ 163.499150] tribuchet[1089]: 2026-11-13T13:25:57.662017Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 163.504110] tribuchet[1089]: 2026-11-13T13:25:57.662107Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="81d3a5159b9d8238586911ef073deccc" hub # [ 166.501642] tribuchet[1089]: 2026-11-13T13:26:00.663894Z WARN tribuchet::hub::state: failing queued build: last capable worker left id="81d3a5159b9d8238586911ef073deccc" hub # [ 167.711956] tribuchet[1089]: 2026-11-13T13:26:01.874951Z INFO tribuchet::hub::submit: no capable worker; declining system="x86_64-linux" worker # [ 160.605698] tribuchet[1922]: 2026-11-13T13:26:00.962814Z 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/phdyav1y3bi1w70knhva14ifbbg24alw-qemu-user-static-x86_64-unknown-linux-musl-11.1.1/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 # [ 160.616834] tribuchet[1922]: 2026-11-13T13:26:00.973651Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 160.626364] tribuchet[1922]: 2026-11-13T13:26:00.983259Z INFO tribuchet::worker::resume: adopted running build id="81d3a5159b9d8238586911ef073deccc" pid=1878 worker # [ 160.634314] nix-daemon[983]: accepted connection from pid 1922, user tribuchet (trusted) worker # [ 160.706063] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1938]: 2026-11-13T13:26:01.063063Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 160.709300] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1938]: 2026-11-13T13:26:01.063161Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 160.712726] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1938]: 2026-11-13T13:26:01.063188Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 160.715644] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1938]: 2026-11-13T13:26:01.063716Z INFO tribuchet::worker::agent: no build held, exiting until the next activation hub # [ 168.301535] tribuchet[1089]: 2026-11-13T13:26:02.464706Z 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 # [ 160.760710] tribuchet[1922]: 2026-11-13T13:26:01.118015Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 168.643675] tribuchet[1089]: 2026-11-13T13:26:02.806999Z INFO tribuchet::hub::submit: queueing build id="9a31f58e2b10accceccf82cffa809605" system="x86_64-linux" hub # [ 168.646617] tribuchet[1089]: 2026-11-13T13:26:02.809975Z INFO tribuchet::hub: dispatching build id="9a31f58e2b10accceccf82cffa809605" worker="worker" worker # [ 161.068193] tribuchet[1922]: 2026-11-13T13:26:01.425318Z INFO tribuchet::worker::session: build resumed id="9a31f58e2b10accceccf82cffa809605" key="859fc8104e9cc1b1caca96546ba777664f0b001397e68c3f47a0c522d90b22dd" hub # [ 168.658292] tribuchet[1089]: 2026-11-13T13:26:02.821617Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="9a31f58e2b10accceccf82cffa809605" [e2e] heartbeat t=150s worker # [ 184.648293] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:26:25.004872Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=29517 cpu_usec=28986858 peak_memory_bytes=1409024 worker # [ 184.648548] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:26:25.005005Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 184.673064] tribuchet[1922]: 2026-11-13T13:26:25.030049Z INFO tribuchet::worker::build::agent_exec: builder finished id="81d3a5159b9d8238586911ef073deccc" exit_code=0 aborted=None worker # [ 184.686726] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1872]: 2026-11-13T13:26:25.044007Z INFO tribuchet::worker::agent: cleanup done id="81d3a5159b9d8238586911ef073deccc" worker # [ 184.796687] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1958]: 2026-11-13T13:26:25.153660Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 184.802231] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1958]: 2026-11-13T13:26:25.159499Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 184.802338] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1958]: 2026-11-13T13:26:25.159582Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 184.810959] flz468b2mhrvn3b664skqyjzf7cf77ys-tribuchet-agent[1958]: 2026-11-13T13:26:25.168237Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 184.827036] tribuchet[1922]: 2026-11-13T13:26:25.184319Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="9a31f58e2b10accceccf82cffa809605" hub # [ 192.410672] tribuchet[1089]: 2026-11-13T13:26:26.573040Z INFO tribuchet::hub::relay: build usage id="9a31f58e2b10accceccf82cffa809605" key="859fc8104e9cc1b1caca96546ba777664f0b001397e68c3f47a0c522d90b22dd" exit_code=0 wall_ms=29517 cpu_usec=28986858 peak_memory_bytes=1409024 oom_killed=false worker # [ 184.840904] tribuchet[1922]: 2026-11-13T13:26:25.198211Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="9a31f58e2b10accceccf82cffa809605" worker # [ 185.701858] systemd[1970]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 185.770668] systemd[1970]: 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.37s (finished: subtest: daemon lifecycle, in 170.40 seconds) (finished: run the VM test script, in 195.61 seconds) test script finished in 195.69s cleanup kill QemuMachine (pid 55) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) hub # [2026-11-13T13:26:28Z INFO virtiofsd] Client disconnected, shutting down hub # [2026-11-13T13:26:28Z INFO virtiofsd] Client disconnected, shutting down hub # [2026-11-13T13:26:28Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 54) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) worker # [2026-11-13T13:26:28Z INFO virtiofsd] Client disconnected, shutting down worker # [2026-11-13T13:26:28Z 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/tmpz759njt9/hub_host.socket worker: ssh -o User=root vsock-mux//build/tmpz759njt9/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