Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) start vhost-device-vsock (finished: start vhost-device-vsock, in 0.00 seconds) 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/tmpvcwub6is/hub_host.socket worker: ssh -o User=root vsock-mux//build/tmpvcwub6is/worker_host.socket Test will time out and terminate in 3600.0 seconds run the VM test script 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 start all VMs hub: starting vm worker: starting vm hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.7GtmxYXyfH', 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: 784006c6-922f-4b3d-a235-661063391b64 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: QEMU running (pid 54) 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:08.0 CB00 PCI2.10 PnP PMM 7EFCC660 7EF2C660 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:08.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 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/lp57wn7wqagyk82qwjljhh01mrrzivig-nixos-system-hub-test/init regInfo=/nix/store/lkdp1lvzmyi6sqmp9rv6gxw3icv37a9a-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. 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 = 0x400000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000001] kvm-clock: using sched offset of 735956007 cycles hub # [ 0.000005] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000014] tsc: Detected 3099.998 MHz processor hub # [ 0.001345] last_pfn = 0x180000 max_arch_pfn = 0x400000000 hub # [ 0.001397] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.001404] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.001477] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.004248] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.004308] Using GB pages for direct mapping hub # [ 0.004557] RAMDISK: [mem 0x7e369000-0x7ffcffff] hub # [ 0.004584] ACPI: Early table checksum verification disabled hub # [ 0.004596] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) hub # [ 0.004606] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004616] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004628] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004633] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.004636] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004640] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004643] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004646] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004648] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] hub # [ 0.004650] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] hub # [ 0.004651] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.004652] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] hub # [ 0.004653] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] hub # [ 0.004654] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] hub # [ 0.004655] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] hub # [ 0.005390] No NUMA configuration found hub # [ 0.005393] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] hub # [ 0.005398] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff] hub # [ 0.005670] Zone ranges: hub # [ 0.005672] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005675] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] hub # [ 0.005677] Normal [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005679] Device empty hub # [ 0.005680] Movable zone start for each node hub # [ 0.005681] Early memory node ranges hub # [ 0.005682] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005684] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.005686] node 0: [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005689] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] hub # [ 0.005729] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006302] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.108587] On node 0, zone Normal: 40 pages in unavailable ranges hub # [ 0.109824] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.109850] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.109879] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.109883] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.109885] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.109887] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.109888] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.109889] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.109892] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.109896] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.109913] TSC deadline timer available hub # [ 0.109923] CPU topo: Max. logical packages: 1 hub # [ 0.109924] CPU topo: Max. logical dies: 1 hub # [ 0.109925] CPU topo: Max. dies per package: 1 hub # [ 0.109930] CPU topo: Max. threads per core: 1 hub # [ 0.109933] CPU topo: Num. cores per package: 1 hub # [ 0.109934] CPU topo: Num. threads per package: 1 hub # [ 0.109935] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.109962] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.110015] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.110017] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.110018] PM: hibernation: Registered nosave memory: [mem 0x7ffd8000-0xffffffff] hub # [ 0.110020] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.110024] Booting paravirtualized kernel on KVM hub # [ 0.110037] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.115840] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.118586] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.118665] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.118667] 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/lp57wn7wqagyk82qwjljhh01mrrzivig-nixos-system-hub-test/init regInfo=/nix/store/lkdp1lvzmyi6sqmp9rv6gxw3icv37a9a-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.118859] Unknown kernel command line parameters "regInfo=/nix/store/lkdp1lvzmyi6sqmp9rv6gxw3icv37a9a-closure-info/registration", will be passed to user space. hub # [ 0.118887] random: crng init done hub # [ 0.118888] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.124244] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) hub # [ 0.127490] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.127562] software IO TLB: area num 1. hub # [ 0.237134] Fallback order for Node 0: 0 hub # [ 0.237167] Built 1 zonelists, mobility grouping on. Total pages: 1048438 hub # [ 0.237170] Policy zone: Normal hub # [ 0.240252] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.262971] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.273798] allocated 8388608 bytes of page_ext hub # [ 0.288235] ftrace: allocating 48733 entries in 192 pages hub # [ 0.288243] ftrace: allocated 192 pages with 2 groups hub # [ 0.289424] Dynamic Preempt: lazy hub # [ 0.289821] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.289825] rcu: RCU event tracing is enabled. hub # [ 0.289826] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.289828] Trampoline variant of Tasks RCU enabled. hub # [ 0.289831] Rude variant of Tasks RCU enabled. hub # [ 0.289832] Tracing variant of Tasks RCU enabled. hub # [ 0.289833] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.289834] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.289860] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.289862] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.289863] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.296343] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.296769] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.296780] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.296927] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.304372] Console: colour VGA+ 80x25 hub # [ 0.304393] printk: legacy console [tty0] enabled hub # [ 0.351635] printk: legacy console [ttyS0] enabled hub # [ 0.560273] ACPI: Core revision 20250807 hub # [ 0.562090] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.564767] APIC: Switch to symmetric I/O mode setup hub # [ 0.566436] x2apic enabled hub # [ 0.567611] APIC: Switched APIC routing to: physical x2apic hub # [ 0.570458] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.572216] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.575161] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) hub # [ 0.576269] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.579251] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.580160] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.582171] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.584160] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.586164] Spectre V2 : Mitigation: Retpolines hub # [ 0.587157] RETBleed: Mitigation: untrained return thunk hub # [ 0.588158] Speculative Return Stack Overflow: Mitigation: SMT disabled hub # [ 0.589159] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.591158] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT hub # [ 0.592158] Spectre V2 : Enabling Speculation Barrier for firmware calls hub # [ 0.593159] active return thunk: retbleed_return_thunk hub # [ 0.594165] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.596180] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.597167] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.598163] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.600161] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.602157] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. hub # [ 0.640906] Freeing SMP alternatives memory: 44K hub # [ 0.642180] pid_max: default: 32768 minimum: 301 hub # [ 0.643292] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.646213] landlock: Up and running. hub # [ 0.647157] Yama: becoming mindful. hub # [ 0.648489] LSM support for eBPF active hub # [ 0.650266] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.651262] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.653971] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) hub # [ 0.654875] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.656165] ... version: 0 hub # [ 0.657183] ... bit width: 48 hub # [ 0.658159] ... generic counters: 6 hub # [ 0.659159] ... generic bitmap: 000000000000003f hub # [ 0.660161] ... fixed-purpose counters: 0 hub # [ 0.661170] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.662159] ... value mask: 0000ffffffffffff hub # [ 0.663159] ... max period: 00007fffffffffff hub # [ 0.664158] ... global_ctrl mask: 000000000000003f hub # [ 0.665369] signal: max sigframe size: 1776 hub # [ 0.666390] rcu: Hierarchical SRCU implementation. hub # [ 0.667164] rcu: Max phase no-delay instances is 400. hub # [ 0.673122] smp: Bringing up secondary CPUs ... hub # [ 0.674177] smp: Brought up 1 node, 1 CPU hub # [ 0.675182] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) hub # [ 0.676583] Memory: 3962416K/4193752K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 217656K reserved, 0K cma-reserved) hub # [ 0.679858] devtmpfs: initialized hub # [ 0.681372] x86/mm: Memory block size: 128MB hub # [ 0.683836] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.685209] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.686402] pinctrl core: initialized pinctrl subsystem hub # [ 0.687834] PM: RTC time: 11:37:06, date: 2026-09-01 hub # [ 0.693140] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.695135] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.696334] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.697768] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.699204] audit: initializing netlink subsys (disabled) hub # [ 0.700667] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.700672] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.701170] audit: type=2000 audit(1788262626.296:1): state=initialized audit_enabled=0 res=1 hub # [ 0.703184] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.703189] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.704160] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.705246] cpuidle: using governor menu hub # [ 0.708284] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.709583] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.710176] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.711195] PCI: Using configuration type 1 for base access hub # [ 0.712527] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.717517] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.722159] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.723160] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.728162] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.733862] ACPI: Added _OSI(Module Device) hub # [ 0.735099] ACPI: Added _OSI(Processor Device) hub # [ 0.742165] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.747911] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.754657] ACPI: Interpreter enabled hub # [ 0.755197] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.758162] ACPI: Using IOAPIC for interrupt routing hub # [ 0.759256] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.762164] PCI: Using E820 reservations for host bridge windows hub # [ 0.763377] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.772188] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.773167] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.774242] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.775267] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.776729] PCI host bridge to bus 0000:00 hub # [ 0.777168] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.778184] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.779173] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.780169] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.781180] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.782167] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.783167] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.784376] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.786026] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.789270] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.790195] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.791228] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.792423] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.794210] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.797445] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.798178] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.799210] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] hub # [ 0.801182] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.803567] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.806182] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.807175] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.808211] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] hub # [ 0.810495] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.814179] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.815189] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.816215] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] hub # [ 0.818494] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.821182] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.822174] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.823207] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] hub # [ 0.825375] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.828113] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.829175] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.830207] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] hub # [ 0.832361] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.835161] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.836172] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.837210] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] hub # [ 0.839501] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.842186] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.843212] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.845236] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] hub # [ 0.846443] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.848723] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.853232] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.854242] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] hub # [ 0.856982] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.860231] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.861228] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.862308] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] hub # [ 0.866335] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.870213] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] hub # [ 0.871200] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.872216] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] hub # [ 0.876402] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.879211] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.881698] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 0.885181] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.888283] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] hub # [ 0.889857] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.893135] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] hub # [ 0.894710] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.898296] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] hub # [ 0.900311] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.904186] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.906029] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.907828] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.909735] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.913224] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] hub # [ 0.914175] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] hub # [ 0.916426] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.920268] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.931822] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.933449] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.934358] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.935345] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.936444] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.937416] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.938411] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.939496] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.940302] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.941197] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.942186] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.943190] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.944185] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.945187] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.946178] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.947191] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.949598] iommu: Default domain type: Translated hub # [ 0.950169] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.951524] ACPI: bus type USB registered hub # [ 0.952286] usbcore: registered new interface driver usbfs hub # [ 0.953193] usbcore: registered new interface driver hub hub # [ 0.954177] usbcore: registered new device driver usb hub # [ 0.956179] NetLabel: Initializing hub # [ 0.957158] NetLabel: domain hash size = 128 hub # [ 0.958158] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.959244] NetLabel: unlabeled traffic allowed by default hub # [ 0.960172] PCI: Using ACPI for IRQ routing hub # [ 1.056757] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 1.057154] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 1.057154] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 1.057177] vgaarb: loaded hub # [ 1.058258] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 1.059158] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 1.064359] clocksource: Switched to clocksource kvm-clock hub # [ 1.069394] VFS: Disk quotas dquot_6.6.0 hub # [ 1.070554] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 1.072966] pnp: PnP ACPI init hub # [ 1.074173] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 1.075765] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 1.078155] pnp: PnP ACPI: found 6 devices hub # [ 1.086160] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 1.088681] clocksource: Switched to clocksource acpi_pm hub # [ 1.090475] NET: Registered PF_INET protocol family hub # [ 1.092833] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) hub # [ 1.112840] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) hub # [ 1.115041] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 1.117152] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 1.120683] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) hub # [ 1.122589] TCP: Hash tables configured (established 32768 bind 32768) hub # [ 1.124672] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) hub # [ 1.126787] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 1.128759] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 1.131358] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 1.133274] NET: Registered PF_XDP protocol family hub # [ 1.134882] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 1.136688] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 1.138469] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 1.140431] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 1.142620] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 1.145346] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] hub # [ 1.150372] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 1.156959] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 1.160719] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 1.164518] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 1.167181] PCI: CLS 0 bytes, default 64 hub # [ 1.168705] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) hub # [ 1.170965] software IO TLB: mapped [mem 0x000000007a369000-0x000000007e369000] (64MB) hub # [ 1.174987] Trying to unpack rootfs image as initramfs... hub # [ 1.190229] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 1.259820] Initialise system trusted keyrings hub # [ 1.263503] workingset: timestamp_bits=40 max_order=20 bucket_order=0 hub # [ 1.293111] Key type asymmetric registered hub # [ 1.296434] Asymmetric key parser 'x509' registered hub # [ 1.297937] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 1.305592] io scheduler mq-deadline registered hub # [ 1.306952] io scheduler kyber registered hub # [ 1.312245] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 1.315884] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 1.325287] Linux agpgart interface v0.103 hub # [ 1.328568] ACPI: bus type drm_connector registered hub # [ 1.332668] usbcore: registered new interface driver usbserial_generic hub # [ 1.334565] usbserial: USB Serial support registered for generic hub # [ 1.339444] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 1.341742] drop_monitor: Initializing network drop monitor service hub # [ 1.347655] NET: Registered PF_INET6 protocol family hub # [ 1.352654] Segment Routing with IPv6 hub # [ 1.353765] In-situ OAM (IOAM) with IPv6 hub # [ 1.356957] IPI shorthand broadcast: enabled hub # [ 1.364723] sched_clock: Marking stable (1093027438, 271375970)->(1655073584, -290670176) hub # [ 1.372850] registered taskstats version 1 hub # [ 1.376487] Loading compiled-in X.509 certificates hub # [ 1.393129] Demotion targets for Node 0: null hub # [ 1.396684] Key type .fscrypt registered hub # [ 1.399436] Key type fscrypt-provisioning registered hub # [ 1.401013] ima: No TPM chip found, activating TPM-bypass! hub # [ 1.405448] ima: Allocated hash algorithm: sha1 hub # [ 1.406790] ima: No architecture policies found hub # [ 1.412694] PM: Magic number: 10:838:629 hub # [ 1.417754] RAS: Correctable Errors collector initialized. hub # [ 1.431186] clk: Disabling unused clocks hub # [ 1.436485] PM: genpd: Disabling unused power domains hub # [ 1.815652] Freeing initrd memory: 29084K hub # [ 1.828609] Freeing unused decrypted memory: 2028K hub # [ 1.833849] Freeing unused kernel image (initmem) memory: 3644K hub # [ 1.838074] Write protecting the kernel read-only data: 32768k hub # [ 1.841284] Freeing unused kernel image (text/rodata gap) memory: 1216K hub # [ 1.844786] Freeing unused kernel image (rodata/data gap) memory: 756K hub # [ 1.905691] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.910328] Run /init as init process hub # [ 1.924972] systemd[1]: Inserted module 'autofs4' hub # [ 1.953454] fuse: init (API version 7.45) hub # [ 1.961315] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.966931] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.973741] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.981521] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 2.037489] systemd[1]: Successfully made /usr/ read-only. hub # [ 2.374727] systemd[1]: systemd 261.2 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 # [ 2.383224] systemd[1]: Detected virtualization kvm. hub # [ 2.384721] systemd[1]: Detected architecture x86-64. hub # [ 2.386128] systemd[1]: Running in initrd. hub # [ 2.387910] systemd[1]: Initializing machine ID from random generator. hub # [ 2.389937] systemd[1]: Hostname set to . hub # [ 2.599047] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 2.647088] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 2.652299] systemd[1]: Created slice Slice /system/modprobe. hub # [ 2.654344] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 2.661496] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 2.663353] systemd[1]: Reached target Path Units. hub # [ 2.664837] systemd[1]: Reached target Slice Units. hub # [ 2.666328] systemd[1]: Reached target Swaps. hub # [ 2.667719] systemd[1]: Reached target Timer Units. hub # [ 2.669537] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 2.671576] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 2.673577] systemd[1]: Listening on Journal Sockets. hub # [ 2.675145] systemd[1]: Listening on udev Control Socket. hub # [ 2.677004] systemd[1]: Listening on udev Kernel Socket. hub # [ 2.678605] systemd[1]: Reached target Socket Units. hub # [ 2.681476] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 2.688075] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.702969] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.717636] systemd[1]: Starting Journal Service... hub # [ 2.736561] systemd[1]: Starting Load Kernel Modules... hub # [ 2.745314] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.749666] netfs: FS-Cache loaded hub # [ 2.764660] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.780256] 9pnet: Installing 9P2000 support hub # [ 2.820947] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.832699] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.848829] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.862484] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.874556] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.876994] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.885199] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.889702] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.897513] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.915795] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.946636] systemd[1]: Finished Load Kernel Modules. hub # [ 2.963779] systemd[1]: Starting Apply Kernel Variables... hub # [ 3.003585] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 3.022941] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 3.052586] systemd[1]: Finished Apply Kernel Variables. hub # [ 3.105569] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 3.113087] systemd[1]: Started Journal Service. hub # [ 2.839852] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.846817] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.850545] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.873955] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.879161] systemd[1]: Reached target Local File Systems. hub # [ 2.884146] systemd[1]: Starting Create System Files and Directories... hub # [ 2.895761] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.945380] systemd[1]: Finished Create System Files and Directories. hub # [ 2.978591] systemd-udevd[83]: Using default interface naming scheme 'v261'. hub # [ 3.000269] systemd[1]: Finished Coldplug All udev Devices. hub # [ 3.019176] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 3.021547] systemd[1]: Reached target System Initialization. hub # [ 3.024367] systemd[1]: Reached target Basic System. hub # [ 3.683946] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 3.688482] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 3.694009] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 hub # [ 3.703449] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 3.707154] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 3.711221] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.715408] usb usb1: Product: EHCI Host Controller hub # [ 3.719414] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd hub # [ 3.721010] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 3.723712] hub 1-0:1.0: USB hub found hub # [ 3.726571] hub 1-0:1.0: 6 ports detected hub # [ 3.752461] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 3.757101] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 3.758993] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 3.784699] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 3.792168] virtio_blk virtio5: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) hub # [ 3.796634] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 3.797865] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 3.803981] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 3.806927] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 hub # [ 3.827711] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.844512] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.865445] usb usb2: Product: UHCI Host Controller hub # [ 3.874235] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd hub # [ 3.896163] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 3.910507] hub 2-0:1.0: USB hub found hub # [ 3.924418] hub 2-0:1.0: 2 ports detected hub # [ 3.662624] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 3.666667] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.673548] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.948331] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 3.956011] SCSI subsystem initialized hub # [ 3.690450] systemd[1]: Starting Virtual Console Setup... hub # [ 3.968419] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 3.991855] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 3.999434] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 3.743626] systemd-vconsole-setup[109]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 3.748506] systemd[1]: Finished Virtual Console Setup. hub # [ 4.024783] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 4.034036] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 hub # [ 4.041617] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 4.049397] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.785341] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 3.789127] systemd[1]: Reached target Initrd Root Device. hub # [ 3.794125] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 4.067292] usb usb3: Product: UHCI Host Controller hub # [ 4.068465] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd hub # [ 4.074522] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 4.086484] hub 3-0:1.0: USB hub found hub # [ 4.088811] hub 3-0:1.0: 2 ports detected hub # [ 4.095339] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 4.099997] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 4.105211] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 4.109071] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 4.110875] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 4.117401] usb 1-1: Product: QEMU USB Tablet hub # [ 4.120830] usb 1-1: Manufacturer: QEMU hub # [ 4.122770] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 hub # [ 4.124187] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 3.855389] systemd-fsck[116]: nixos: clean, 12/262144 files, 37198/1048576 blocks hub # [ 4.130735] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.864454] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 4.145476] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 4.150263] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 4.151973] usb usb4: Product: UHCI Host Controller hub # [ 4.155409] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd hub # [ 4.159519] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 4.162428] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 4.167123] hub 4-0:1.0: USB hub found hub # [ 4.169472] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 4.170913] hub 4-0:1.0: 2 ports detected hub # [ 4.185491] scsi host0: ahci hub # [ 4.189993] scsi host1: ahci hub # [ 4.197037] scsi host2: ahci hub # [ 4.206859] scsi host3: ahci hub # [ 4.213475] scsi host4: ahci hub # [ 4.221011] scsi host5: ahci hub # [ 4.225238] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 44 lpm-pol 1 hub # [ 4.230603] hid: raw HID events driver (C) Jiri Kosina hub # [ 4.234153] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 44 lpm-pol 1 hub # [ 4.242544] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 44 lpm-pol 1 hub # [ 4.245019] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 44 lpm-pol 1 hub # [ 4.247200] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 44 lpm-pol 1 hub # [ 4.249679] usbcore: registered new interface driver usbhid hub # [ 4.251607] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 44 lpm-pol 1 hub # [ 4.254690] usbhid: USB HID core driver hub # [ 4.568864] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 4.571019] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 4.572743] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 4.575098] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 4.576866] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 4.578647] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 4.580225] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 4.581924] ata3.00: applying bridge limits hub # [ 4.583078] ata3.00: configured for UDMA/100 hub # [ 4.584664] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 4.623917] 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 # [ 4.630528] 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 # [ 4.646497] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 4.657608] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 4.521602] systemd[1]: Mounting /sysroot... hub # [ 4.919415] EXT4-fs (vda): mounted filesystem 784006c6-922f-4b3d-a235-661063391b64 r/w with ordered data mode. Quota mode: none. hub # [ 4.652638] systemd[1]: Mounted /sysroot. hub # [ 4.654667] systemd[1]: Reached target Initrd Root File System. hub # [ 4.657686] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 4.669185] systemd-sysroot-fstab-check[151]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 4.674119] systemd[1]: Reload requested from client PID 151 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 4.676642] systemd[1]: Reloading... hub # [ 4.756539] systemd[1]: Reloading finished in 82 ms. hub # [ 4.765572] systemd-sysroot-fstab-check[151]: Requesting initrd-fs.target/start/replace... hub # [ 4.769614] systemd-sysroot-fstab-check[151]: Requesting swap.target/start/replace... hub # [ 4.771423] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 4.776312] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 4.778246] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 4.780099] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 5.522133] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 5.525364] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 5.532148] systemd[1]: Mounting /sysroot/run... hub # [ 5.542286] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 5.551799] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 5.573729] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 5.847075] 9p: Installing v9fs 9p2000 file system support hub # [ 5.589274] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 5.596185] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 5.600678] systemd[1]: Mounted /sysroot/run. hub # [ 5.610256] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 5.611936] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 5.622805] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 5.625684] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 5.630175] systemd[1]: Mounting /sysroot/nix/store... hub # [ 5.658276] systemd[1]: Mounted /sysroot/nix/store. hub # [ 5.660465] systemd[1]: Reached target Initrd File Systems. hub # [ 5.663668] systemd[1]: Starting Find NixOS closure... hub # [ 5.669635] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 5.692443] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 5.705315] systemd[1]: Finished Find NixOS closure. hub # [ 5.708824] systemd[1]: Reached target Initrd Default Target. hub # [ 5.712975] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 5.734514] systemd[1]: Stopped target Initrd Default Target. hub # [ 5.736732] systemd[1]: Stopped target Basic System. hub # [ 5.738726] systemd[1]: Stopped target Initrd Root Device. hub # [ 5.741395] systemd[1]: Stopped target Path Units. hub # [ 5.742665] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 5.744454] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 5.747436] systemd[1]: Stopped target Slice Units. hub # [ 5.749210] systemd[1]: Stopped target Socket Units. hub # [ 5.751147] systemd[1]: Stopped target System Initialization. hub # [ 5.753310] systemd[1]: Stopped target Swaps. hub # [ 5.754677] systemd[1]: Stopped target Timer Units. hub # [ 5.756245] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 5.758424] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 5.761396] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 5.763418] systemd[1]: Stopped Find NixOS closure. hub # [ 5.765454] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 5.768786] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 5.771411] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 5.773620] systemd[1]: Stopped Apply Kernel Variables. hub # [ 5.775562] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 5.777499] systemd[1]: Stopped Load Kernel Modules. hub # [ 5.779649] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 5.782769] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 5.785241] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 5.788247] systemd[1]: Stopped Create System Files and Directories. hub # [ 5.790232] systemd[1]: Stopped target Local File Systems. hub # [ 5.791609] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 5.794226] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 5.796619] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 5.799156] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 5.803489] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 5.805862] systemd[1]: Stopped Virtual Console Setup. hub # [ 5.822128] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 5.827129] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 5.836667] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 5.840149] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 5.842753] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 5.845278] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 5.848648] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 5.851304] systemd[1]: Closed udev Control Socket. hub # [ 5.855165] systemd[1]: Starting Cleanup udev Database... hub # [ 5.857325] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 5.859551] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 5.862334] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 5.864329] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 5.866240] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 5.869283] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 5.889408] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 5.892173] systemd[1]: Finished Cleanup udev Database. hub # [ 5.893712] systemd[1]: Reached target Switch Root. hub # [ 5.896862] systemd[1]: Starting NixOS Activation... hub # [ 6.262233] initrd-nixos-activation-start[200]: booting system configuration /nix/store/lp57wn7wqagyk82qwjljhh01mrrzivig-nixos-system-hub-test hub # [ 6.355983] initrd-nixos-activation-start[200]: running activation script... hub # [ 7.091380] initrd-nixos-activation-start[223]: setting up /etc... hub # [ 7.747862] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 7.752410] systemd[1]: Finished NixOS Activation. hub # [ 7.756120] systemd[1]: Starting Switch Root... hub # [ 7.780743] systemd[1]: Switching root. hub # [ 8.265395] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 8.432043] NET: Registered PF_VSOCK protocol family hub # [ 8.868110] systemd[1]: systemd 261.2 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 # [ 8.886253] systemd[1]: Detected virtualization kvm. hub # [ 8.888088] systemd[1]: Detected architecture x86-64. hub # [ 8.889845] systemd[1]: Detected first boot. hub # [ 8.904919] systemd[1]: Initializing machine ID from random generator. hub # [ 9.039840] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 9.243150] systemd[1]: Applying preset policy. worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.xGCdE29W6R', fmt=raw size=4294967296 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/1048576 done worker # Creating filesystem with 1048576 4k blocks and 262144 inodes worker # Filesystem UUID: 91d929d3-a4ba-473d-b235-140aea5e30a2 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: QEMU running (pid 55) (finished: start all VMs, in 11.43 seconds) hub: waiting for unit multi-user.target hub: waiting for the VM to finish booting worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) worker # worker # worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC510+7EF2C510 CA00 worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC510 7EF2C510 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)... worker # worker # worker # Booting from ROM... worker # Probing EDD (edd=off to disable)... ok hub # [ 10.165635] systemd[1]: Populated /etc with preset unit settings. worker # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 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/lxhh74rri4c6rggn8pilm6yg5b3hjvy4-nixos-system-worker-test/init regInfo=/nix/store/fm410w9hikxak7qw782dbxpm4mi0fc3p-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. 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 = 0x400000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000001] kvm-clock: using sched offset of 694041794 cycles worker # [ 0.000004] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000009] tsc: Detected 3099.998 MHz processor worker # [ 0.000840] last_pfn = 0x180000 max_arch_pfn = 0x400000000 worker # [ 0.000879] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000883] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.000948] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.003250] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.003283] Using GB pages for direct mapping worker # [ 0.003406] RAMDISK: [mem 0x7e35d000-0x7ffcffff] worker # [ 0.003418] ACPI: Early table checksum verification disabled worker # [ 0.003425] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) worker # [ 0.003431] ACPI: RSDT 0x000000007FFE248E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003448] ACPI: FACP 0x000000007FFE227E 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003457] ACPI: DSDT 0x000000007FFE0040 00223E (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003459] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.003461] ACPI: APIC 0x000000007FFE2372 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003464] ACPI: HPET 0x000000007FFE23F2 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003466] ACPI: MCFG 0x000000007FFE242A 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003468] ACPI: WAET 0x000000007FFE2466 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003470] ACPI: Reserving FACP table memory at [mem 0x7ffe227e-0x7ffe2371] worker # [ 0.003471] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227d] worker # [ 0.003472] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.003472] ACPI: Reserving APIC table memory at [mem 0x7ffe2372-0x7ffe23f1] worker # [ 0.003473] ACPI: Reserving HPET table memory at [mem 0x7ffe23f2-0x7ffe2429] worker # [ 0.003474] ACPI: Reserving MCFG table memory at [mem 0x7ffe242a-0x7ffe2465] worker # [ 0.003474] ACPI: Reserving WAET table memory at [mem 0x7ffe2466-0x7ffe248d] worker # [ 0.003943] No NUMA configuration found worker # [ 0.003945] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] worker # [ 0.003948] NODE_DATA(0) allocated [mem 0x17fff8780-0x17fffdcff] worker # [ 0.004066] Zone ranges: worker # [ 0.004068] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.004069] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] worker # [ 0.004071] Normal [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.004072] Device empty worker # [ 0.004073] Movable zone start for each node worker # [ 0.004074] Early memory node ranges worker # [ 0.004074] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.004075] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.004076] node 0: [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.004077] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] worker # [ 0.004450] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.004764] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.118693] On node 0, zone Normal: 43 pages in unavailable ranges worker # [ 0.120095] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.120121] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.120163] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.120168] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.120171] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.120172] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.120174] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.120175] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.120181] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.120182] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.120195] TSC deadline timer available worker # [ 0.120204] CPU topo: Max. logical packages: 1 worker # [ 0.120206] CPU topo: Max. logical dies: 1 worker # [ 0.120206] CPU topo: Max. dies per package: 1 worker # [ 0.120214] CPU topo: Max. threads per core: 1 worker # [ 0.120215] CPU topo: Num. cores per package: 2 worker # [ 0.120216] CPU topo: Num. threads per package: 2 worker # [ 0.120216] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs worker # [ 0.120247] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.120269] kvm-guest: KVM setup pv remote TLB flush worker # [ 0.120273] kvm-guest: setup PV sched yield worker # [ 0.120284] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.120287] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.120288] PM: hibernation: Registered nosave memory: [mem 0x7ffd5000-0xffffffff] worker # [ 0.120291] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.120293] Booting paravirtualized kernel on KVM worker # [ 0.120299] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.126355] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 worker # [ 0.129871] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u1048576 worker # [ 0.129953] kvm-guest: PV spinlocks enabled worker # [ 0.129957] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) worker # [ 0.129961] 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/lxhh74rri4c6rggn8pilm6yg5b3hjvy4-nixos-system-worker-test/init regInfo=/nix/store/fm410w9hikxak7qw782dbxpm4mi0fc3p-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.130147] Unknown kernel command line parameters "regInfo=/nix/store/fm410w9hikxak7qw782dbxpm4mi0fc3p-closure-info/registration", will be passed to user space. worker # [ 0.130171] random: crng init done worker # [ 0.130172] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.136950] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) worker # [ 0.147989] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.148126] software IO TLB: area num 2. worker # [ 0.266661] Fallback order for Node 0: 0 worker # [ 0.266677] Built 1 zonelists, mobility grouping on. Total pages: 1048435 worker # [ 0.266681] Policy zone: Normal worker # [ 0.270405] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.287760] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 worker # [ 0.301228] allocated 8388608 bytes of page_ext worker # [ 0.314771] ftrace: allocating 48733 entries in 192 pages worker # [ 0.314777] ftrace: allocated 192 pages with 2 groups worker # [ 0.316525] Dynamic Preempt: lazy worker # [ 0.316796] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.316797] rcu: RCU event tracing is enabled. worker # [ 0.316798] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. worker # [ 0.316801] Trampoline variant of Tasks RCU enabled. worker # [ 0.316802] Rude variant of Tasks RCU enabled. worker # [ 0.316802] Tracing variant of Tasks RCU enabled. worker # [ 0.316803] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.316805] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 worker # [ 0.316836] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.316839] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.316840] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. worker # [ 0.322628] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 worker # [ 0.323105] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.323118] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.323276] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.330118] Console: colour VGA+ 80x25 worker # [ 0.330127] printk: legacy console [tty0] enabled worker # [ 0.384487] printk: legacy console [ttyS0] enabled worker # [ 0.577821] ACPI: Core revision 20250807 worker # [ 0.579354] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.582268] APIC: Switch to symmetric I/O mode setup worker # [ 0.584134] x2apic enabled worker # [ 0.585537] APIC: Switched APIC routing to: physical x2apic worker # [ 0.587265] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() worker # [ 0.589488] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() worker # [ 0.592231] kvm-guest: setup PV IPIs worker # [ 0.604806] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.606670] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.609846] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) worker # [ 0.611958] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.613059] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.613841] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.614850] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.615844] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.616846] Spectre V2 : Mitigation: Retpolines worker # [ 0.618838] RETBleed: Mitigation: untrained return thunk worker # [ 0.619837] Speculative Return Stack Overflow: Mitigation: SMT disabled worker # [ 0.621837] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.623861] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT worker # [ 0.624841] Spectre V2 : Enabling Speculation Barrier for firmware calls worker # [ 0.626842] active return thunk: retbleed_return_thunk worker # [ 0.628843] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.629862] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.631838] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.633838] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.635850] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.637837] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. worker # [ 0.671633] Freeing SMP alternatives memory: 44K worker # [ 0.672845] pid_max: default: 32768 minimum: 301 worker # [ 0.674019] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.676856] landlock: Up and running. worker # [ 0.677838] Yama: becoming mindful. worker # [ 0.679128] LSM support for eBPF active worker # [ 0.680990] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.681959] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.684960] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) worker # [ 0.686741] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.687846] ... version: 0 worker # [ 0.688839] ... bit width: 48 worker # [ 0.689839] ... generic counters: 6 worker # [ 0.690839] ... generic bitmap: 000000000000003f worker # [ 0.691840] ... fixed-purpose counters: 0 worker # [ 0.692839] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.693840] ... value mask: 0000ffffffffffff worker # [ 0.694843] ... max period: 00007fffffffffff worker # [ 0.695839] ... global_ctrl mask: 000000000000003f worker # [ 0.697031] signal: max sigframe size: 1776 worker # [ 0.698043] rcu: Hierarchical SRCU implementation. worker # [ 0.698845] rcu: Max phase no-delay instances is 400. worker # [ 0.700307] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level worker # [ 0.707373] smp: Bringing up secondary CPUs ... worker # [ 0.708407] smpboot: x86: Booting SMP configuration: worker # [ 0.708853] .... node #0, CPUs: #1 worker # [ 0.711940] smp: Brought up 1 node, 2 CPUs worker # [ 0.713864] smpboot: Total of 2 processors activated (12399.99 BogoMIPS) worker # [ 0.715272] Memory: 3961020K/4193740K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 218116K reserved, 0K cma-reserved) worker # [ 0.719841] devtmpfs: initialized worker # [ 0.721179] x86/mm: Memory block size: 128MB worker # [ 0.724921] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.725932] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). worker # [ 0.727139] pinctrl core: initialized pinctrl subsystem worker # [ 0.728433] PM: RTC time: 11:37:16, date: 2026-09-01 worker # [ 0.732799] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.734897] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.735909] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.737585] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.738884] audit: initializing netlink subsys (disabled) worker # [ 0.739991] audit: type=2000 audit(1788262637.048:1): state=initialized audit_enabled=0 res=1 worker # [ 0.740945] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.741841] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.742842] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.744841] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.746842] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.748964] cpuidle: using governor menu worker # [ 0.753742] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.755465] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.758847] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.760889] PCI: Using configuration type 1 for base access worker # [ 0.763003] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.777915] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.778841] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.779848] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.781033] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.790432] ACPI: Added _OSI(Module Device) worker # [ 0.790840] ACPI: Added _OSI(Processor Device) worker # [ 0.791840] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.794853] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.799093] ACPI: Interpreter enabled worker # [ 0.799941] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.800842] ACPI: Using IOAPIC for interrupt routing worker # [ 0.803003] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.805844] PCI: Using E820 reservations for host bridge windows worker # [ 0.807037] ACPI: Enabled 2 GPEs in block 00 to 3F worker # [ 0.813986] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.814854] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.817942] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.819919] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.822605] PCI host bridge to bus 0000:00 worker # [ 0.823736] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.825857] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.827855] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.830869] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.832868] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.834878] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.837871] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.840265] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.842942] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.858655] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.860874] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.862899] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.865162] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.868465] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.876877] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.878857] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.879904] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] worker # [ 0.882860] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.886548] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.891865] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.893887] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.896047] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] worker # [ 0.899672] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.905865] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.906863] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.908903] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] worker # [ 0.912242] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.916951] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.918884] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.921915] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] worker # [ 0.926833] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.931863] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.932872] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.934933] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] worker # [ 0.940327] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.944876] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.946857] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.947902] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] worker # [ 0.952392] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.956874] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.957855] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.958889] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] worker # [ 0.961856] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.970114] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.973618] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.974903] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] worker # [ 0.978219] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.984861] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.985873] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.987905] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] hub # [ 11.482788] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 0.991261] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 11.485349] systemd[1]: Stopped initrd-switch-root.service. worker # [ 0.999869] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f] worker # [ 1.001872] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 11.496168] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 1.003919] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] hub # [ 11.500012] systemd[1]: Created slice Slice /system/getty. hub # [ 11.502615] systemd[1]: Created slice User and Session Slice. hub # [ 11.504411] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.008270] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint hub # [ 11.507405] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 11.509486] systemd[1]: Expecting device /dev/hvc0... worker # [ 1.013877] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] hub # [ 11.511014] systemd[1]: Expecting device /dev/ttyS0... hub # [ 11.512440] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 1.015932] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 11.514401] systemd[1]: Stopped target initrd-fs.target. hub # [ 11.515791] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 11.517305] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 1.018833] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 11.519192] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 11.520765] systemd[1]: Reached target Path Units. hub # [ 11.521839] systemd[1]: Reached target Remote File Systems. worker # [ 1.022677] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f] hub # [ 11.523159] systemd[1]: Reached target Slice Units. hub # [ 11.524594] systemd[1]: Reached target Swaps. worker # [ 1.024349] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 1.028911] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f] worker # [ 1.030340] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 11.532039] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 1.034446] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f] worker # [ 1.036431] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 11.540399] systemd[1]: Listening on Process Core Dump Socket. worker # [ 1.040627] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] worker # [ 1.043751] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 11.547051] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 1.046506] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 1.049415] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 11.552074] systemd[1]: Listening on Factory Reset Management. hub # [ 11.553907] systemd[1]: Listening on Hostname Service Socket. worker # [ 1.055104] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf] worker # [ 1.056858] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] worker # [ 1.058855] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 11.561118] systemd[1]: Starting Journal Log Access Socket... worker # [ 1.062907] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 11.564108] systemd[1]: Listening on Journal Audit Socket. hub # [ 11.569565] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 11.571945] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 1.072818] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 11.575045] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.075023] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 11.577425] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 1.077068] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 1.079088] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 1.081001] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 1.082982] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 1.084963] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 1.087020] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 1.087887] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 1.089860] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 1.091864] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 1.092859] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 1.094894] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 11.596450] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 1.096881] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 11.598461] systemd[1]: Listening on udev Control Socket. worker # [ 1.098885] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 11.600153] systemd[1]: Listening on udev Varlink Socket. worker # [ 1.099871] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 1.104157] iommu: Default domain type: Translated worker # [ 1.105841] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 1.108549] ACPI: bus type USB registered hub # [ 11.609724] systemd[1]: Mounting Huge Pages File System... worker # [ 1.109015] usbcore: registered new interface driver usbfs worker # [ 1.110876] usbcore: registered new interface driver hub worker # [ 1.111934] usbcore: registered new device driver usb hub # [ 11.616535] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 1.113659] NetLabel: Initializing worker # [ 1.113833] NetLabel: domain hash size = 128 worker # [ 1.115840] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 1.116908] NetLabel: unlabeled traffic allowed by default worker # [ 1.117858] PCI: Using ACPI for IRQ routing hub # [ 11.630039] systemd[1]: Mounting Kernel Debug File System... hub # [ 11.639569] systemd[1]: Mounting Kernel Trace File System... hub # [ 11.653906] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 11.663128] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 11.682933] systemd[1]: Starting Load Kernel Module configfs... hub # [ 11.685114] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 11.687985] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 11.690619] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 1.220174] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 1.220833] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 1.220833] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 1.225857] vgaarb: loaded worker # [ 1.226951] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 1.227851] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 11.745400] systemd[1]: Mounting FUSE Control File System... worker # [ 1.231851] clocksource: Switched to clocksource kvm-clock worker # [ 1.236939] VFS: Disk quotas dquot_6.6.0 hub # [ 11.748648] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 1.238249] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 1.240913] pnp: PnP ACPI init worker # [ 1.242259] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 1.244018] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 1.246538] pnp: PnP ACPI: found 6 devices worker # [ 1.258356] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 1.262024] clocksource: Switched to clocksource acpi_pm worker # [ 1.263990] NET: Registered PF_INET protocol family worker # [ 1.266277] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) hub # [ 11.782147] systemd[1]: Starting Journal Service... hub # [ 11.795585] systemd[1]: Starting Load Kernel Modules... worker # [ 1.287618] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) worker # [ 1.289960] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 1.292762] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 1.295117] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) worker # [ 1.297390] TCP: Hash tables configured (established 32768 bind 32768) worker # [ 1.299498] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) hub # [ 11.812811] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 1.302012] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 1.304197] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 1.306458] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 1.308178] NET: Registered PF_XDP protocol family worker # [ 1.309615] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 1.311335] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 1.313156] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 1.315247] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] worker # [ 1.317152] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 1.319097] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] hub # [ 11.834125] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 1.322103] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 1.325083] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 1.328013] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 1.330700] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 11.847645] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.333337] PCI: CLS 0 bytes, default 64 worker # [ 1.337452] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) worker # [ 1.338268] Trying to unpack rootfs image as initramfs... worker # [ 1.339236] software IO TLB: mapped [mem 0x000000007a35d000-0x000000007e35d000] (64MB) worker # [ 1.343322] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 11.871820] systemd[1]: Starting Coldplug All udev Devices... worker # [ 1.365049] Initialise system trusted keyrings worker # [ 1.367522] workingset: timestamp_bits=40 max_order=20 bucket_order=0 hub # [ 11.894869] systemd-journald[293]: Collecting audit messages is enabled. worker # [ 1.383650] Key type asymmetric registered worker # [ 1.385153] Asymmetric key parser 'x509' registered worker # [ 1.386913] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 1.389695] io scheduler mq-deadline registered worker # [ 1.391243] io scheduler kyber registered worker # [ 1.396272] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 11.911644] systemd[1]: Listening on Journal Log Access Socket. worker # [ 1.398376] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 1.402082] Linux agpgart interface v0.103 worker # [ 1.403631] ACPI: bus type drm_connector registered hub # [ 11.918147] loop: module loaded worker # [ 1.406252] usbcore: registered new interface driver usbserial_generic hub # [ 11.920683] systemd[1]: Mounted Huge Pages File System. worker # [ 1.408120] usbserial: USB Serial support registered for generic worker # [ 1.409993] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 1.412659] drop_monitor: Initializing network drop monitor service worker # [ 1.414934] NET: Registered PF_INET6 protocol family worker # [ 1.418497] Segment Routing with IPv6 hub # [ 11.931236] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 1.419831] In-situ OAM (IOAM) with IPv6 worker # [ 1.422178] IPI shorthand broadcast: enabled worker # [ 1.427339] sched_clock: Marking stable (1149033885, 277716062)->(1511382897, -84632950) hub # [ 11.941815] systemd[1]: Mounted Kernel Debug File System. worker # [ 1.430872] registered taskstats version 1 worker # [ 1.432692] Loading compiled-in X.509 certificates hub # [ 11.949704] systemd[1]: Mounted Kernel Trace File System. worker # [ 1.446228] Demotion targets for Node 0: null hub # [ 11.958946] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 1.448093] Key type .fscrypt registered worker # [ 1.449436] Key type fscrypt-provisioning registered hub # [ 11.963444] EXT4-fs (vda): re-mounted 784006c6-922f-4b3d-a235-661063391b64. worker # [ 1.451335] ima: No TPM chip found, activating TPM-bypass! worker # [ 1.453151] ima: Allocated hash algorithm: sha1 worker # [ 1.454653] ima: No architecture policies found hub # [ 11.967487] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 1.456663] PM: Magic number: 10:838:629 worker # [ 1.459609] RAS: Correctable Errors collector initialized. worker # [ 1.466877] clk: Disabling unused clocks hub # [ 11.980404] systemd[1]: Finished Load Kernel Module configfs. worker # [ 1.468268] PM: genpd: Disabling unused power domains hub # [ 11.989594] systemd[1]: Started Journal Service. hub # [ 11.765350] systemd-oomd[295]: No swap; memory pressure usage will be degraded hub # [ 12.179933] systemd-journald[293]: Received client request to flush runtime journal. worker # [ 1.779505] Freeing initrd memory: 29132K worker # [ 1.786980] Freeing unused decrypted memory: 2028K worker # [ 1.791845] Freeing unused kernel image (initmem) memory: 3644K worker # [ 1.793640] Write protecting the kernel read-only data: 32768k worker # [ 1.796883] Freeing unused kernel image (text/rodata gap) memory: 1216K worker # [ 1.799407] Freeing unused kernel image (rodata/data gap) memory: 756K worker # [ 1.841395] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.843293] Run /init as init process worker # [ 1.858661] systemd[1]: Inserted module 'autofs4' worker # [ 1.885804] fuse: init (API version 7.45) worker # [ 1.896136] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.900220] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.905581] ACPI: \_SB_.GSIE: Enabled at IRQ 20 worker # [ 1.909126] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.952000] systemd[1]: Successfully made /usr/ read-only. worker # [ 2.290031] systemd[1]: systemd 261.2 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 # [ 2.304648] systemd[1]: Detected virtualization kvm. worker # [ 2.306289] systemd[1]: Detected architecture x86-64. worker # [ 2.307882] systemd[1]: Running in initrd. worker # [ 2.309651] systemd[1]: Initializing machine ID from random generator. worker # [ 2.311965] systemd[1]: Hostname set to . worker # [ 2.419368] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.462212] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 2.472318] systemd[1]: Created slice Slice /system/modprobe. worker # [ 2.474361] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 2.476938] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 2.478892] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 2.480681] systemd[1]: Reached target Path Units. worker # [ 2.482154] systemd[1]: Reached target Slice Units. worker # [ 2.483646] systemd[1]: Reached target Swaps. worker # [ 2.485081] systemd[1]: Reached target Timer Units. worker # [ 2.486846] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 2.489062] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 2.491164] systemd[1]: Listening on Journal Sockets. worker # [ 2.492981] systemd[1]: Listening on udev Control Socket. worker # [ 2.503956] systemd[1]: Listening on udev Kernel Socket. worker # [ 2.510629] systemd[1]: Reached target Socket Units. worker # [ 2.537834] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 2.566178] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 2.570847] systemd[1]: Starting Load Kernel Module configfs... worker # [ 2.616072] systemd[1]: Starting Journal Service... worker # [ 2.632576] systemd[1]: Starting Load Kernel Modules... worker # [ 2.644034] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.661192] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.680954] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.688218] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.692915] netfs: FS-Cache loaded worker # [ 2.709436] 9pnet: Installing 9P2000 support worker # [ 2.714416] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.718852] systemd-journald[75]: Collecting audit messages is disabled. worker # [ 2.726929] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.743914] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 2.754944] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.761536] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.765822] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.772503] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.778001] systemd[1]: Finished Load Kernel Modules. worker # [ 2.783903] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.793883] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.800821] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.545467] systemd-modules-load[76]: Using 2 probe threads worker # [ 2.826108] systemd[1]: Started Journal Service. worker # [ 2.549841] systemd-modules-load[76]: Inserted module 'virtio_balloon' worker # [ 2.551866] systemd-modules-load[76]: Inserted module 'virtio_gpu' worker # [ 2.554640] systemd-modules-load[76]: Inserted module 'dm_mod' worker # [ 2.559270] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.562393] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.570163] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.572368] systemd[1]: Reached target Local File Systems. worker # [ 2.575049] systemd[1]: Starting Create System Files and Directories... worker # [ 2.577527] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.606161] systemd[1]: Finished Create System Files and Directories. worker # [ 2.610869] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.622829] systemd-udevd[93]: Using default interface naming scheme 'v261'. worker # [ 2.640412] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.642495] systemd[1]: Reached target System Initialization. worker # [ 2.644539] systemd[1]: Reached target Basic System. worker # [ 3.110297] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 3.111754] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1 worker # [ 3.118613] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 3.120613] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c240 worker # [ 3.132138] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.134040] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.142336] usb usb1: Product: UHCI Host Controller worker # [ 3.144667] usb usb1: Manufacturer: Linux 6.18.48 uhci_hcd worker # [ 3.146247] usb usb1: SerialNumber: 0000:00:1d.0 worker # [ 3.157640] hub 1-0:1.0: USB hub found worker # [ 3.159899] hub 1-0:1.0: 2 ports detected worker # [ 3.166355] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 3.171554] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 3.173079] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 3.183054] virtio_blk virtio4: 2/0/0 default/read/poll queues worker # [ 3.186501] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 3.188102] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2 worker # [ 3.190210] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 worker # [ 3.197845] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 3.198894] virtio_blk virtio4: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) worker # [ 3.201137] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 3.204312] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.206183] usb usb2: Product: EHCI Host Controller worker # [ 3.208400] usb usb2: Manufacturer: Linux 6.18.48 ehci_hcd worker # [ 3.209665] usb usb2: SerialNumber: 0000:00:1d.7 worker # [ 3.210360] virtio_blk virtio5: 2/0/0 default/read/poll queues worker # [ 3.213382] hub 2-0:1.0: USB hub found worker # [ 3.215487] hub 2-0:1.0: 6 ports detected worker # [ 3.222249] virtio_blk virtio5: [vdb] 2598200 512-byte logical blocks (1.33 GB/1.24 GiB) worker # [ 3.240192] hub 1-0:1.0: USB hub found worker # [ 3.241284] hub 1-0:1.0: 2 ports detected worker # [ 3.243745] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 3.245004] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 3.249392] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 13.497098] (udev-worker)[425]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 3.264636] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c260 worker # [ 2.989057] systemd[1]: Starting Virtual Console Setup... worker # [ 3.269330] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.993936] (udev-worker)[106]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.278528] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.285593] usb usb3: Product: UHCI Host Controller worker # [ 3.289739] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd worker # [ 3.291160] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 3.299226] hub 3-0:1.0: USB hub found worker # [ 3.301004] hub 3-0:1.0: 2 ports detected worker # [ 3.301388] SCSI subsystem initialized worker # [ 3.324063] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 3.053188] systemd-vconsole-setup[120]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 3.061753] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 3.065193] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.067510] systemd[1]: Finished Virtual Console Setup. worker # [ 3.350785] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 3.358761] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 3.364790] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 3.366483] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c280 worker # [ 3.369592] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.371804] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.373341] usb usb4: Product: UHCI Host Controller worker # [ 3.374418] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd worker # [ 3.375652] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 3.105916] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 3.388878] hub 4-0:1.0: USB hub found worker # [ 3.113942] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 3.116922] systemd[1]: Reach[ 3.394413] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # ed target Initrd[ 3.394799] hub 4-0:1.0: 2 ports detected worker # Root Device. worker # [ 3.397949] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 3.122940] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 3.405930] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 3.416902] scsi host0: ahci worker # [ 3.424682] scsi host1: ahci worker # [ 3.426236] scsi host2: ahci worker # [ 3.430168] scsi host3: ahci worker # [ 3.435868] scsi host4: ahci worker # [ 3.438886] scsi host5: ahci worker # [ 3.162498] systemd-fsck[136]: nixos: clean, 12/262144 files, 37198/1048576 blocks worker # [ 3.442287] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 46 lpm-pol 1 worker # [ 3.446901] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 46 lpm-pol 1 worker # [ 3.172111] systemd[1]: Finished File System [ 3.450017] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 46 lpm-pol 1 worker # Check on /dev/disk/by-label/nixos. worker # [ 3.452416] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 46 lpm-pol 1 worker # [ 3.454492] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 46 lpm-pol 1 worker # [ 3.456908] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 46 lpm-pol 1 worker # [ 3.459807] usb 2-1: new high-speed USB device number 2 using ehci-pci worker # [ 3.591043] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.593032] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.594673] usb 2-1: Product: QEMU USB Tablet worker # [ 3.595852] usb 2-1: Manufacturer: QEMU worker # [ 3.596937] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 3.616120] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.392655] systemd[1]: Mounting /sysroot... hub # [ 14.272142] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 3.770458] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 3.772086] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 3.774057] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 3.775678] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 3.777362] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.778773] ata3.00: applying bridge limits worker # [ 3.780103] ata2: SATA link down (SStatus 0 SControl 300) worker # [ 3.782235] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 3.784385] ata3.00: configured for UDMA/100 worker # [ 3.786261] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 14.307497] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console hub # [ 14.337346] ACPI: button: Power Button [PWRF] worker # [ 3.829400] usbcore: registered new interface driver usbhid worker # [ 3.833312] usbhid: USB HID core driver worker # [ 3.844406] 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 # [ 3.850360] 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 # [ 3.862071] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.900006] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 14.413655] mousedev: PS/2 mouse device common for all mice hub # [ 14.428770] Console: switching to colour dummy device 80x25 hub # [ 14.461121] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 14.461125] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 3.950564] EXT4-fs (vda): mounted filesystem 91d929d3-a4ba-473d-b235-140aea5e30a2 r/w with ordered data mode. Quota mode: none. hub # [ 14.470905] rtc_cmos 00:04: RTC can wake from S4 worker # [ 3.683778] systemd[1]: Mounted /sysroot. worker # [ 3.685926] systemd[1]: Reached target Initrd Root File System. worker # [ 3.689907] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 14.481412] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 3.692886] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.705256] systemd[1]: Mounting /sysroot/run... hub # [ 14.495727] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 3.712317] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 14.508062] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 3.724443] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 14.520534] rtc_cmos 00:04: registered as rtc0 worker # [ 3.730402] systemd[1]: Starting Mountpoints Configured in the Real Root...[ 4.008859] erofs (device vdb): mounted with root inode @ nid 36. worker # hub # [ 14.529867] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 worker # [ 3.745814] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 14.536571] rtc_cmos 00:04: setting system clock to 2026-09-01T11:37:20 UTC (1788262640) worker # [ 3.749314] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.750650] systemd[1]: Mounted /sysroot/run. hub # [ 14.554419] parport_pc 00:02: reported by Plug and Play ACPI hub # [ 14.555599] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 3.766472] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 14.561707] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 3.769448] systemd-sysroot-fstab-check[168]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 4.055455] 9p: Installing v9fs 9p2000 file system support worker # [ 3.779614] systemd[1]: Reload requested from client PID 168 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.783338] systemd[1]: Reloading... hub # [ 14.646168] Console: switching to colour frame buffer device 160x50 worker # [ 3.887372] systemd[1]: Reloading finished in 106 ms. worker # [ 3.907648] systemd-sysroot-fstab-check[168]: Requesting initrd-fs.target/start/replace... hub # [ 14.692206] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 3.913539] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.915623] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 14.692414] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 3.918100] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.920271] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.925866] systemd-sysroot-fstab-check[168]: Requesting swap.target/start/replace... worker # [ 3.934114] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.935606] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.937349] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.939569] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 14.735414] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 3.961537] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.963838] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.968203] systemd[1]: Mounting /sysroot/nix/store... hub # [ 14.773722] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 14.776052] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 4.010420] systemd[1]: Mounted /sysroot/nix/store. worker # [ 4.012111] systemd[1]: Reached target Initrd File Systems. worker # [ 4.016456] systemd[1]: Starting Find NixOS closure... worker # [ 4.018586] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 14.551532] systemd-ssh-issue[591]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # [ 4.041360] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 4.052492] systemd[1]: Finished Find NixOS closure. worker # [ 4.054294] systemd[1]: Reached target Initrd Default Target. worker # [ 4.057459] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 4.080155] systemd[1]: Stopped target Initrd Default Target. worker # [ 4.081938] systemd[1]: Stopped target Basic System. worker # [ 4.083775] systemd[1]: Stopped target Initrd Root Device. worker # [ 4.085286] systemd[1]: Stopped target Path Units. worker # [ 4.086617] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 4.088532] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 4.090549] systemd[1]: Stopped target Slice Units. worker # [ 4.091924] systemd[1]: Stopped target Socket Units. worker # [ 4.093326] systemd[1]: Stopped target System Initialization. worker # [ 4.094775] systemd[1]: Stopped target Swaps. worker # [ 4.097159] systemd[1]: Stopped target Timer Units. worker # [ 4.098420] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.099868] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 4.101531] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 4.104740] systemd[1]: Stopped Find NixOS closure. worker # [ 4.106464] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 4.109657] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 4.114263] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 4.115986] systemd[1]: Stopped Apply Kernel Variables. worker # [ 4.117405] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 4.121494] systemd[1]: Stopped Load Kernel Modules. worker # [ 4.122760] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 4.125175] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 4.127976] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 4.129720] systemd[1]: Stopped Create System Files and Directories. worker # [ 4.131398] systemd[1]: Stopped target Local File Systems. worker # [ 4.132925] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 4.134536] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 4.136411] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 4.137945] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 4.139836] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 4.143230] systemd[1]: Stopped Virtual Console Setup. worker # [ 4.144771] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 4.146640] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 4.148365] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 4.150175] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 4.151666] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 4.153175] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 4.154909] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 4.156678] systemd[1]: Closed udev Control Socket. worker # [ 4.158085] systemd[1]: Starting Cleanup udev Database... worker # [ 4.159510] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 4.161407] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 4.163166] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 4.165424] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 4.167347] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 4.170362] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 4.172061] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 4.174223] systemd[1]: Finished Cleanup udev Database. worker # [ 4.175566] systemd[1]: Reached target Switch Root. worker # [ 4.177129] systemd[1]: Starting NixOS Activation... worker # [ 4.261989] initrd-nixos-activation-start[220]: booting system configuration /nix/store/lxhh74rri4c6rggn8pilm6yg5b3hjvy4-nixos-system-worker-test worker # [ 4.291994] initrd-nixos-activation-start[220]: running activation script... hub # [ 15.142026] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # connecting to host... hub # [ 15.168155] ppdev: user-space parallel port driver hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 5.50 seconds) hub: (finished: waiting for the VM to finish booting, in 5.50 seconds) hub # [ 15.253456] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 4.533816] initrd-nixos-activation-start[243]: setting up /etc... worker # [ 4.638179] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.640391] systemd[1]: Finished NixOS Activation. worker # [ 4.644330] systemd[1]: Starting Switch Root... worker # [ 4.666292] systemd[1]: Switching root. worker # [ 4.990725] systemd-journald[75]: Received SIGTERM from PID 1 (systemd). worker # [ 5.155601] NET: Registered PF_VSOCK protocol family hub # [ 15.992488] kvm_amd: TSC scaling supported hub # [ 15.999345] kvm_amd: Nested Virtualization enabled hub # [ 16.007171] kvm_amd: Nested Paging enabled hub # [ 16.010323] kvm_amd: LBR virtualization supported hub # [ 16.011073] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 16.017065] kvm_amd: Virtual GIF supported hub # [ 16.099128] EDAC MC: Ver: 3.0.0 worker # [ 5.736628] systemd[1]: systemd 261.2 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.743050] systemd[1]: Detected virtualization kvm. worker # [ 5.744531] systemd[1]: Detected architecture x86-64. worker # [ 5.745927] systemd[1]: Detected first boot. worker # [ 5.747484] systemd[1]: Initializing machine ID from random generator. worker # [ 5.890596] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 6.020511] systemd[1]: Applying preset policy. hub # [ 16.627146] 8021q: 802.1Q VLAN Support v1.8 hub # [ 16.629597] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 16.378646] systemd-vconsole-setup[695]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 6.145856] systemd[1]: Populated /etc with preset unit settings. worker # [ 6.306289] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 6.309475] systemd[1]: Stopped initrd-switch-root.service. worker # [ 6.313622] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 6.317439] systemd[1]: Created slice Slice /system/getty. worker # [ 6.320385] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 6.323156] systemd[1]: Created slice User and Session Slice. worker # [ 6.324978] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 6.327209] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 6.329578] systemd[1]: Expecting device /dev/hvc0... worker # [ 6.331025] systemd[1]: Expecting device /dev/ttyS0... worker # [ 6.332437] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 6.333841] systemd[1]: Stopped target initrd-fs.target. worker # [ 6.335135] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 6.336548] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 6.338081] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 6.339850] systemd[1]: Reached target Path Units. worker # [ 6.341081] systemd[1]: Reached target Remote File Systems. worker # [ 6.342378] systemd[1]: Reached target Slice Units. worker # [ 6.343550] systemd[1]: Reached target Swaps. worker # [ 6.346102] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 6.349066] systemd[1]: Listening on Process Core Dump Socket. worker # [ 6.351301] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 6.353860] systemd[1]: Listening on Factory Reset Management. worker # [ 6.355315] systemd[1]: Listening on Hostname Service Socket. worker # [ 6.359145] systemd[1]: Starting Journal Log Access Socket... worker # [ 6.360958] systemd[1]: Listening on Journal Audit Socket. worker # [ 6.363533] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 6.365501] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 6.367324] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.369266] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 6.373279] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 6.374941] systemd[1]: Listening on udev Control Socket. worker # [ 6.376392] systemd[1]: Listening on udev Varlink Socket. worker # [ 6.380818] systemd[1]: Mounting Huge Pages File System... worker # [ 6.385822] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 6.397367] systemd[1]: Mounting Kernel Debug File System... worker # [ 6.406234] systemd[1]: Mounting Kernel Trace File System... worker # [ 6.412013] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 6.416074] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 16.937786] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 6.427796] systemd[1]: Starting Load Kernel Module configfs... worker # [ 6.433895] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 6.437163] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.439703] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.444967] systemd[1]: Mounting FUSE Control File System... worker # [ 6.446607] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.458054] systemd[1]: Starting Journal Service... worker # [ 6.465853] systemd[1]: Starting Load Kernel Modules... worker # [ 6.473840] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 6.482208] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 6.485846] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.490936] systemd[1]: Starting Coldplug All udev Devices... hub # [ 17.005664] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 17.007385] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 6.497630] systemd[1]: Listening on Journal Log Access Socket. hub # [ 17.012682] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 17.014001] cfg80211: failed to load regulatory.db worker # [ 6.501025] systemd[1]: Mounted Huge Pages File System. worker # [ 6.503546] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 6.507089] systemd[1]: Mounted Kernel Debug File System. worker # [ 6.510537] systemd[1]: Mounted Kernel Trace File System. worker # [ 6.512899] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 6.512940] loop: module loaded worker # [ 6.513584] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 6.518279] systemd-journald[318]: Collecting audit messages is enabled. worker # [ 6.521633] systemd[1]: Finished Load Kernel Module configfs. worker # [ 6.523503] systemd[1]: Mounted FUSE Control File System. worker # [ 6.528389] systemd[1]: Finished Load Kernel Modules. worker # [ 6.536992] systemd[1]: Mounting Kernel Configuration File System... worker # [ 6.545870] systemd[1]: Starting Firewall... worker # [ 6.551243] systemd[1]: Starting Apply Kernel Variables... worker # [ 6.561884] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 6.566158] systemd[1]: Mounted Kernel Configuration File System. worker # [ 6.595592] EXT4-fs (vda): re-mounted 91d929d3-a4ba-473d-b235-140aea5e30a2. worker # [ 6.600357] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 6.604141] systemd[1]: Started Journal Service. hub # [ 17.120733] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 6.370293] systemd-oomd[321]: No swap; memory pressure usage will be degraded worker # [ 6.667338] systemd-journald[318]: Received client request to flush runtime journal. hub # [ 17.398369] NET: Registered PF_PACKET protocol family worker # [ 6.722264] (udev-worker)[422]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 7.088462] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 7.095738] mousedev: PS/2 mouse device common for all mice worker # [ 7.102834] ACPI: button: Power Button [PWRF] worker # [ 7.126867] rtc_cmos 00:04: RTC can wake from S4 worker # [ 7.138869] rtc_cmos 00:04: registered as rtc0 worker # [ 7.141141] rtc_cmos 00:04: setting system clock to 2026-09-01T11:37:22 UTC (1788262642) worker # [ 7.143641] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 7.145782] systemd-journald[318]: Time jumped backwards, rotating. worker # [ 7.150900] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 7.159248] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 7.159377] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 7.160074] Console: switching to colour dummy device 80x25 worker # [ 7.167689] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 7.168342] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 7.171439] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 7.174900] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 7.176397] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 7.218404] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 7.219926] Console: switching to colour frame buffer device 160x50 worker # [ 7.220042] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 7.232346] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 7.235019] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 worker # [ 7.247216] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 7.257443] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 7.180790] systemd-vconsole-setup[497]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 7.633287] ppdev: user-space parallel port driver worker # [ 7.639118] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 7.644557] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 7.676572] kvm_amd: TSC scaling supported worker # [ 7.677338] kvm_amd: Nested Virtualization enabled worker # [ 7.678825] kvm_amd: Nested Paging enabled worker # [ 7.679509] kvm_amd: LBR virtualization supported worker # [ 7.680610] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 7.681636] kvm_amd: Virtual GIF supported worker # [ 7.412170] systemd-vconsole-setup[562]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 7.717942] EDAC MC: Ver: 3.0.0 worker # [ 7.632737] systemd-ssh-issue[570]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # connecting to host... worker # [ 8.386088] 8021q: 802.1Q VLAN Support v1.8 worker # [ 8.388739] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.523545] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 8.529161] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.530385] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.532779] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.534019] cfg80211: failed to load regulatory.db worker # [ 8.558806] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.996808] NET: Registered PF_PACKET protocol family hub: (finished: waiting for unit multi-user.target, in 13.69 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 2.10 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.02 seconds) hub: must succeed: tribuchet ca issue worker --dir /root/ca hub: (finished: must succeed: tribuchet ca issue worker --dir /root/ca, in 0.03 seconds) hub: must succeed: mkdir -p /etc/tribuchet/ca hub: (finished: must succeed: mkdir -p /etc/tribuchet/ca, in 0.04 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.03 seconds) worker: must succeed: mkdir -p /etc/tribuchet/tls worker: (finished: must succeed: mkdir -p /etc/tribuchet/tls, in 0.01 seconds) hub: must succeed: cat /root/ca/worker.crt hub: (finished: must succeed: cat /root/ca/worker.crt, in 0.03 seconds) worker: must succeed: cat > /etc/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBVzCB/6ADAgECAhRJ4hHhzqjQvc6kR6/xO8YvzCRC5DAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDkwMTExMzcz MVoXDTI4MDgzMTExMzczMVowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABE7yyh176Cde7e3VHFgHUMKR i5SS8kpSHFzh/TiXxIZpAks6/Hgoi94AlVCPEtWhk9yCI3qdIchzD6wyvNT8PTSj FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNHADBEAiAVUOa4/Ipn 1MP5fSHeH+lkC5pd36Wz16vNnCl5ITcMdQIgftET+A4pfuXmUNk4pmSxLKdB4sGK lNlfoPqmNKqTrNg= -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBVzCB/6ADAgECAhRJ4hHhzqjQvc6kR6/xO8YvzCRC5DAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDkwMTExMzcz MVoXDTI4MDgzMTExMzczMVowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABE7yyh176Cde7e3VHFgHUMKR i5SS8kpSHFzh/TiXxIZpAks6/Hgoi94AlVCPEtWhk9yCI3qdIchzD6wyvNT8PTSj FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNHADBEAiAVUOa4/Ipn 1MP5fSHeH+lkC5pd36Wz16vNnCl5ITcMdQIgftET+A4pfuXmUNk4pmSxLKdB4sGK lNlfoPqmNKqTrNg= -----END CERTIFICATE----- PEMEOF, in 0.03 seconds) hub: must succeed: cat /root/ca/worker.key hub: (finished: must succeed: cat /root/ca/worker.key, in 0.03 seconds) worker: must succeed: cat > /etc/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgHQPR+7DUPrEk5dnR Pf6SC2P5lPDwQx7eMdi3R1Rz/V2hRANCAARO8sode+gnXu3t1RxYB1DCkYuUkvJK Uhxc4f04l8SGaQJLOvx4KIveAJVQjxLVoZPcgiN6nSHIcw+sMrzU/D00 -----END PRIVATE KEY----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgHQPR+7DUPrEk5dnR Pf6SC2P5lPDwQx7eMdi3R1Rz/V2hRANCAARO8sode+gnXu3t1RxYB1DCkYuUkvJK Uhxc4f04l8SGaQJLOvx4KIveAJVQjxLVoZPcgiN6nSHIcw+sMrzU/D00 -----END PRIVATE KEY----- PEMEOF, in 0.01 seconds) hub: must succeed: cat /root/ca/ca.crt hub: (finished: must succeed: cat /root/ca/ca.crt, in 0.02 seconds) worker: must succeed: cat > /etc/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBkDCCATWgAwIBAgIUT0tlG6+omJQCVzjPc04x3VLeIvEwCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA5MDExMTM3 MzFaFw0zNjA4MjkxMTM3MzFaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQtb2hnpg9XTq96oPWJAHcN 4p1+S09e3eTFwzpsdT0KukQhGvgD3gUcdNtF6YMlvCDa7BzQ7Cd1O1Em7Odnet8p o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFBkHHTNDcCdU 3Fy0V4uu3YEGMfiiMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSQAwRgIh APqrmFSaWq/6yurDSInJLxepUsmF6sBXfkPNyH6vEPVCAiEA9CeBs3nrsJ3JSjCF NbWiNumYDbTJwQ1j1TD16Dj+9k8= -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /etc/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBkDCCATWgAwIBAgIUT0tlG6+omJQCVzjPc04x3VLeIvEwCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA5MDExMTM3 MzFaFw0zNjA4MjkxMTM3MzFaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQtb2hnpg9XTq96oPWJAHcN 4p1+S09e3eTFwzpsdT0KukQhGvgD3gUcdNtF6YMlvCDa7BzQ7Cd1O1Em7Odnet8p o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFBkHHTNDcCdU 3Fy0V4uu3YEGMfiiMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSQAwRgIh APqrmFSaWq/6yurDSInJLxepUsmF6sBXfkPNyH6vEPVCAiEA9CeBs3nrsJ3JSjCF NbWiNumYDbTJwQ1j1TD16Dj+9k8= -----END CERTIFICATE----- PEMEOF, in 0.01 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.31 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.04 seconds) hub: must succeed: systemctl start tribuchet-hub hub # [ 25.696805] tribuchet[988]: 2026-09-01T11:37:31.930446Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 25.706290] tribuchet[988]: 2026-09-01T11:37:31.940613Z 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.08 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 15.238500] tribuchet[904]: 2026-09-01T11:37:30.874677Z 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/3h7cnbgyb34y7c0al8cnarhv32984rxr-qemu-user-static-x86_64-unknown-linux-musl-11.1.0/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, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 15.256147] tribuchet[904]: 2026-09-01T11:37:30.892506Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox") worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.07 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 # [ 15.339833] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[917]: 2026-09-01T11:37:30.975986Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 15.340728] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[917]: 2026-09-01T11:37:30.977068Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 15.341743] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[917]: 2026-09-01T11:37:30.977122Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 15.412358] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[922]: 2026-09-01T11:37:31.048254Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 15.417327] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[922]: 2026-09-01T11:37:31.050717Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 15.421493] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[922]: 2026-09-01T11:37:31.050759Z INFO tribuchet::worker::agent: agent listening uid=61629 hub # [ 25.969902] tribuchet[988]: 2026-09-01T11:37:32.204065Z 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.480302] tribuchet[904]: 2026-09-01T11:37:31.116548Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered', in 1.06 seconds) (finished: subtest: worker registers at hub over mTLS, in 1.29 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.02 seconds) (finished: subtest: worker sshd reachable for the harness backdoor, in 0.05 seconds) subtest: daemon lifecycle running 1 test test lifecycle ... hub # [ 27.261325] systemd[1018]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 27.431087] systemd[1018]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 17.206858] systemd[938]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 17.369822] systemd[938]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 28.996183] tribuchet[988]: 2026-09-01T11:37:35.230181Z INFO tribuchet::hub::submit: queueing build id="da4709a5207c8f3f88dabb2c8985d75a" system="x86_64-linux" hub # [ 29.000467] tribuchet[988]: 2026-09-01T11:37:35.234964Z INFO tribuchet::hub: dispatching build id="da4709a5207c8f3f88dabb2c8985d75a" worker="worker" worker # [ 18.487445] tribuchet[904]: 2026-09-01T11:37:34.123556Z INFO tribuchet::worker::session: build assigned id="da4709a5207c8f3f88dabb2c8985d75a" worker # [ 18.537879] nix-daemon[956]: accepted connection from pid 904, user tribuchet (trusted) hub # [ 29.065121] tribuchet[988]: 2026-09-01T11:37:35.299500Z INFO tribuchet::hub::relay::staging: input path negotiation done id="da4709a5207c8f3f88dabb2c8985d75a" total=8 missing=1 hub # [ 29.149918] nix-daemon[1083]: accepted connection from pid 988, user root (trusted) worker # [ 18.654323] nix-daemon[956]: accepted connection from pid 904, user tribuchet (trusted) worker # [ 18.661825] tribuchet[904]: 2026-09-01T11:37:34.298280Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="da4709a5207c8f3f88dabb2c8985d75a" fixed_output=false network=false net_isolation=false worker # [ 18.679117] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[922]: 2026-09-01T11:37:34.315106Z INFO tribuchet::worker::agent: builder started id="da4709a5207c8f3f88dabb2c8985d75a" pid=966 worker # [ 18.683396] tribuchet[904]: 2026-09-01T11:37:34.319859Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="da4709a5207c8f3f88dabb2c8985d75a" pid=966 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/82866930b80b8d97/build worker # [ 18.697207] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[922]: 2026-09-01T11:37:34.333613Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 18.890188] tribuchet[904]: 2026-09-01T11:37:34.525663Z INFO tribuchet::worker::build::agent_exec: builder finished id="da4709a5207c8f3f88dabb2c8985d75a" exit_code=0 aborted=None worker # [ 18.900170] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[922]: 2026-09-01T11:37:34.536537Z INFO tribuchet::worker::agent: cleanup done id="da4709a5207c8f3f88dabb2c8985d75a" worker # [ 18.969479] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[979]: 2026-09-01T11:37:34.605627Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 18.973650] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[979]: 2026-09-01T11:37:34.607660Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 18.977256] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[979]: 2026-09-01T11:37:34.607699Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 18.980535] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[979]: 2026-09-01T11:37:34.607756Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 18.990830] tribuchet[904]: 2026-09-01T11:37:34.627132Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="da4709a5207c8f3f88dabb2c8985d75a" worker # [ 19.001335] tribuchet[904]: 2026-09-01T11:37:34.637781Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="da4709a5207c8f3f88dabb2c8985d75a" hub # [ 29.979559] tribuchet[988]: 2026-09-01T11:37:36.214143Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 19.465557] tribuchet[904]: 2026-09-01T11:37:35.101838Z WARN tribuchet::worker: hub session ended: code: 'Unknown error', message: "h2 protocol error: error reading a body from connection", source: hyper::Error(Body, Error { kind: Io(Custom { kind: UnexpectedEof, error: "peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof" }) }) worker # [ 19.466223] tribuchet[904]: 2026-09-01T11:37:35.101922Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 30.000469] nix-daemon[1083]: reaped child process 1085, status = succeeded hub # [ 30.025864] tribuchet[1112]: 2026-09-01T11:37:36.259332Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 30.029497] tribuchet[1112]: 2026-09-01T11:37:36.260039Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 30.962891] tribuchet[1112]: 2026-09-01T11:37:37.197227Z INFO tribuchet::hub::submit: no capable worker yet; waiting system="x86_64-linux" hub # [ 30.988498] tribuchet[1112]: 2026-09-01T11:37:37.222910Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] hub # [ 30.994886] tribuchet[1112]: 2026-09-01T11:37:37.229294Z INFO tribuchet::hub::submit: queueing build id="594276258fcbd7be609372ec29f408bc" system="x86_64-linux" worker # [ 20.510451] tribuchet[904]: 2026-09-01T11:37:36.146452Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 31.034302] tribuchet[1112]: 2026-09-01T11:37:37.268311Z INFO tribuchet::hub: dispatching build id="594276258fcbd7be609372ec29f408bc" worker="worker" worker # [ 20.519410] tribuchet[904]: 2026-09-01T11:37:36.155856Z INFO tribuchet::worker::session: build assigned id="594276258fcbd7be609372ec29f408bc" worker # [ 20.525300] nix-daemon[956]: accepted connection from pid 904, user tribuchet (trusted) hub # [ 31.052155] tribuchet[1112]: 2026-09-01T11:37:37.286464Z INFO tribuchet::hub::relay::staging: input path negotiation done id="594276258fcbd7be609372ec29f408bc" total=7 missing=0 worker # [ 20.532849] tribuchet[904]: 2026-09-01T11:37:36.169275Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="594276258fcbd7be609372ec29f408bc" fixed_output=false network=false net_isolation=false worker # [ 20.601648] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:36.237694Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 20.605644] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:36.237823Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 20.609215] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:36.237855Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 20.612382] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:36.244039Z INFO tribuchet::worker::agent: builder started id="594276258fcbd7be609372ec29f408bc" pid=1018 worker # [ 20.616402] tribuchet[904]: 2026-09-01T11:37:36.244103Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="594276258fcbd7be609372ec29f408bc" pid=1018 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/485c99a206726734/build worker # [ 21.135351] tribuchet[904]: 2026-09-01T11:37:36.771827Z INFO tribuchet::worker: handover requested; exiting hub # [ 31.659532] tribuchet[1112]: 2026-09-01T11:37:37.893971Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 31.662602] tribuchet[1112]: 2026-09-01T11:37:37.894048Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="594276258fcbd7be609372ec29f408bc" worker # [ 21.181431] tribuchet[1046]: 2026-09-01T11:37:36.817612Z 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/3h7cnbgyb34y7c0al8cnarhv32984rxr-qemu-user-static-x86_64-unknown-linux-musl-11.1.0/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, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 21.182741] tribuchet[1046]: 2026-09-01T11:37:36.819241Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox") worker # [ 21.208535] tribuchet[1046]: 2026-09-01T11:37:36.845024Z INFO tribuchet::worker::resume: adopted running build id="594276258fcbd7be609372ec29f408bc" pid=1018 worker # [ 21.220903] nix-daemon[956]: accepted connection from pid 1046, user tribuchet (trusted) worker # [ 21.232353] tribuchet[1046]: 2026-09-01T11:37:36.868803Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 31.751372] tribuchet[1112]: 2026-09-01T11:37:37.985454Z 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 # [ 31.759350] tribuchet[1112]: 2026-09-01T11:37:37.985644Z INFO tribuchet::hub: dispatching build id="594276258fcbd7be609372ec29f408bc" worker="worker" worker # [ 21.240227] tribuchet[1046]: 2026-09-01T11:37:36.876629Z INFO tribuchet::worker::session: build resumed id="594276258fcbd7be609372ec29f408bc" key="daa29e29913e13e963a544c9d6f03bfa56c005e3293fe082ea515d5e07c59cee" hub # [ 31.764118] tribuchet[1112]: 2026-09-01T11:37:37.998157Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="594276258fcbd7be609372ec29f408bc" hub # [ 31.892484] tribuchet[1112]: 2026-09-01T11:37:38.126420Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 21.373928] tribuchet[1046]: 2026-09-01T11:37:37.010267Z 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.374637] tribuchet[1046]: 2026-09-01T11:37:37.010315Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 31.936649] tribuchet[1170]: 2026-09-01T11:37:38.170484Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 31.940826] tribuchet[1170]: 2026-09-01T11:37:38.170668Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 32.900133] tribuchet[1170]: 2026-09-01T11:37:39.134608Z 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.388788] tribuchet[1046]: 2026-09-01T11:37:38.024794Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 33.899341] tribuchet[1170]: 2026-09-01T11:37:40.133586Z INFO tribuchet::hub::submit: queueing build id="cf741c4a71d2d8dd4b479812d5a1fe49" system="x86_64-linux" hub # [ 33.903719] tribuchet[1170]: 2026-09-01T11:37:40.137619Z INFO tribuchet::hub: dispatching build id="cf741c4a71d2d8dd4b479812d5a1fe49" worker="worker" worker # [ 23.384887] tribuchet[1046]: 2026-09-01T11:37:39.021335Z INFO tribuchet::worker::session: build resumed id="cf741c4a71d2d8dd4b479812d5a1fe49" key="daa29e29913e13e963a544c9d6f03bfa56c005e3293fe082ea515d5e07c59cee" hub # [ 33.909312] tribuchet[1170]: 2026-09-01T11:37:40.143885Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="cf741c4a71d2d8dd4b479812d5a1fe49" worker # [ 40.369659] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:56.005385Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 40.373191] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:56.005488Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 40.449508] tribuchet[1046]: 2026-09-01T11:37:56.085454Z INFO tribuchet::worker::build::agent_exec: builder finished id="594276258fcbd7be609372ec29f408bc" exit_code=0 aborted=None worker # [ 40.464511] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1012]: 2026-09-01T11:37:56.100922Z INFO tribuchet::worker::agent: cleanup done id="594276258fcbd7be609372ec29f408bc" worker # [ 40.529895] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1079]: 2026-09-01T11:37:56.166004Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 40.534502] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1079]: 2026-09-01T11:37:56.170968Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 40.535241] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1079]: 2026-09-01T11:37:56.171020Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 40.535947] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1079]: 2026-09-01T11:37:56.171088Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 40.619993] tribuchet[1046]: 2026-09-01T11:37:56.256315Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="cf741c4a71d2d8dd4b479812d5a1fe49" worker # [ 40.626839] tribuchet[1046]: 2026-09-01T11:37:56.263256Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="cf741c4a71d2d8dd4b479812d5a1fe49" worker # [ 41.854704] systemd[1091]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 41.950967] systemd[1091]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 52.969074] tribuchet[1170]: 2026-09-01T11:37:59.202025Z INFO tribuchet::hub::submit: queueing build id="fa4f324ef80cf44aff1e9654d01f95a1" system="x86_64-linux" worker # [ 42.450169] tribuchet[1046]: 2026-09-01T11:37:58.086238Z INFO tribuchet::worker::session: build assigned id="fa4f324ef80cf44aff1e9654d01f95a1" hub # [ 52.972838] tribuchet[1170]: 2026-09-01T11:37:59.202097Z INFO tribuchet::hub: dispatching build id="fa4f324ef80cf44aff1e9654d01f95a1" worker="worker" worker # [ 42.457338] nix-daemon[956]: accepted connection from pid 1046, user tribuchet (trusted) hub # [ 52.984278] tribuchet[1170]: 2026-09-01T11:37:59.218547Z INFO tribuchet::hub::relay::staging: input path negotiation done id="fa4f324ef80cf44aff1e9654d01f95a1" total=7 missing=0 worker # [ 42.464812] tribuchet[1046]: 2026-09-01T11:37:58.101251Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="fa4f324ef80cf44aff1e9654d01f95a1" fixed_output=false network=false net_isolation=false worker # [ 42.535551] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1112]: 2026-09-01T11:37:58.171709Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 42.540084] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1112]: 2026-09-01T11:37:58.174686Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 42.544101] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1112]: 2026-09-01T11:37:58.174729Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 42.552396] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1112]: 2026-09-01T11:37:58.188856Z INFO tribuchet::worker::agent: builder started id="fa4f324ef80cf44aff1e9654d01f95a1" pid=1118 worker # [ 42.556711] tribuchet[1046]: 2026-09-01T11:37:58.188922Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="fa4f324ef80cf44aff1e9654d01f95a1" pid=1118 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/14583ea2dbc53f5e/build [e2e] heartbeat t=30s worker # [ 62.366808] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1112]: 2026-09-01T11:38:18.002621Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 62.374490] tribuchet[1046]: 2026-09-01T11:38:18.010671Z INFO tribuchet::worker::build::agent_exec: builder finished id="fa4f324ef80cf44aff1e9654d01f95a1" exit_code=0 aborted=None worker # [ 62.386492] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1112]: 2026-09-01T11:38:18.022908Z INFO tribuchet::worker::agent: cleanup done id="fa4f324ef80cf44aff1e9654d01f95a1" worker # [ 62.456358] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1137]: 2026-09-01T11:38:18.092500Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 62.460475] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1137]: 2026-09-01T11:38:18.096965Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 62.461406] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1137]: 2026-09-01T11:38:18.097001Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 62.462156] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1137]: 2026-09-01T11:38:18.097049Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 62.490710] tribuchet[1046]: 2026-09-01T11:38:18.127110Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="fa4f324ef80cf44aff1e9654d01f95a1" worker # [ 62.496857] tribuchet[1046]: 2026-09-01T11:38:18.133326Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="fa4f324ef80cf44aff1e9654d01f95a1" worker # [ 62.723204] systemd[1149]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 62.798706] systemd[1149]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 63.179609] tribuchet[1046]: 2026-09-01T11:38:18.816032Z INFO tribuchet::worker::session: build assigned id="ad0012659ef6e67d4e72c9f2e5af34eb" hub # [ 73.698519] tribuchet[1170]: 2026-09-01T11:38:19.932368Z INFO tribuchet::hub::submit: queueing build id="ad0012659ef6e67d4e72c9f2e5af34eb" system="x86_64-linux" hub # [ 73.702558] tribuchet[1170]: 2026-09-01T11:38:19.932430Z INFO tribuchet::hub: dispatching build id="ad0012659ef6e67d4e72c9f2e5af34eb" worker="worker" worker # [ 63.186943] nix-daemon[956]: accepted connection from pid 1046, user tribuchet (trusted) hub # [ 73.712386] tribuchet[1170]: 2026-09-01T11:38:19.946943Z INFO tribuchet::hub::relay::staging: input path negotiation done id="ad0012659ef6e67d4e72c9f2e5af34eb" total=7 missing=0 worker # [ 63.193162] tribuchet[1046]: 2026-09-01T11:38:18.829539Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="ad0012659ef6e67d4e72c9f2e5af34eb" fixed_output=false network=false net_isolation=false worker # [ 63.266563] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:18.902782Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 63.271694] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:18.903764Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 63.276001] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:18.903807Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 63.284253] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:18.912152Z INFO tribuchet::worker::agent: builder started id="ad0012659ef6e67d4e72c9f2e5af34eb" pid=1192 worker # [ 63.284741] tribuchet[1046]: 2026-09-01T11:38:18.912211Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="ad0012659ef6e67d4e72c9f2e5af34eb" pid=1192 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/312c108fcf78b153/build worker # [ 63.862992] tribuchet[1046]: 2026-09-01T11:38:19.499169Z INFO tribuchet::worker: handover requested; exiting hub # [ 74.385539] tribuchet[1170]: 2026-09-01T11:38:20.619901Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 74.388850] tribuchet[1170]: 2026-09-01T11:38:20.620011Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="ad0012659ef6e67d4e72c9f2e5af34eb" worker # [ 63.904902] tribuchet[1219]: 2026-09-01T11:38:19.541185Z 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/3h7cnbgyb34y7c0al8cnarhv32984rxr-qemu-user-static-x86_64-unknown-linux-musl-11.1.0/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, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 63.907048] tribuchet[1219]: 2026-09-01T11:38:19.542413Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox") worker # [ 63.912575] tribuchet[1219]: 2026-09-01T11:38:19.549068Z INFO tribuchet::worker::resume: adopted running build id="ad0012659ef6e67d4e72c9f2e5af34eb" pid=1192 worker # [ 63.924991] nix-daemon[956]: accepted connection from pid 1219, user tribuchet (trusted) worker # [ 63.938548] tribuchet[1219]: 2026-09-01T11:38:19.575025Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 74.457575] tribuchet[1170]: 2026-09-01T11:38:20.691636Z 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 # [ 63.939502] tribuchet[1219]: 2026-09-01T11:38:19.575821Z INFO tribuchet::worker::session: build resumed id="ad0012659ef6e67d4e72c9f2e5af34eb" key="d4462946d06ab85715dcf218450923c0b1fd203eed76699a175f7c5746c783a4" hub # [ 74.463962] tribuchet[1170]: 2026-09-01T11:38:20.691837Z INFO tribuchet::hub: dispatching build id="ad0012659ef6e67d4e72c9f2e5af34eb" worker="worker" hub # [ 74.468581] tribuchet[1170]: 2026-09-01T11:38:20.703000Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="ad0012659ef6e67d4e72c9f2e5af34eb" [e2e] heartbeat t=60s worker # [ 77.553601] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:33.188988Z INFO tribuchet::worker::agent: builder exited code=137 worker # [ 77.557517] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:33.189714Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 77.762598] tribuchet[1219]: 2026-09-01T11:38:33.398554Z INFO tribuchet::worker::build::agent_exec: builder finished id="ad0012659ef6e67d4e72c9f2e5af34eb" exit_code=137 aborted=Some("build log exceeded the limit of 1048576 bytes") worker # [ 77.769268] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1186]: 2026-09-01T11:38:33.403252Z INFO tribuchet::worker::agent: cleanup done id="ad0012659ef6e67d4e72c9f2e5af34eb" worker # [ 77.835749] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1243]: 2026-09-01T11:38:33.471542Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 77.836722] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1243]: 2026-09-01T11:38:33.471750Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 77.843452] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1243]: 2026-09-01T11:38:33.471787Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 77.844195] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1243]: 2026-09-01T11:38:33.471837Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 77.918747] tribuchet[1219]: 2026-09-01T11:38:33.555148Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="ad0012659ef6e67d4e72c9f2e5af34eb" worker # [ 77.924554] tribuchet[1219]: 2026-09-01T11:38:33.560960Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="ad0012659ef6e67d4e72c9f2e5af34eb" hub # [ 88.463836] systemd[1]: slowlogbuild.service: Main process exited, code=exited, status=100/n/a hub # [ 88.466355] systemd[1]: slowlogbuild.service: Failed with result 'exit-code'. worker # [ 78.342825] systemd[1255]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 78.422164] systemd[1255]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 89.437875] tribuchet[1170]: 2026-09-01T11:38:35.671892Z INFO tribuchet::hub::submit: queueing build id="5c39d4b87f0fd520e74527bdc674e981" system="x86_64-linux" worker # [ 78.919651] tribuchet[1219]: 2026-09-01T11:38:34.555650Z INFO tribuchet::worker::session: build assigned id="5c39d4b87f0fd520e74527bdc674e981" hub # [ 89.441386] tribuchet[1170]: 2026-09-01T11:38:35.671965Z INFO tribuchet::hub: dispatching build id="5c39d4b87f0fd520e74527bdc674e981" worker="worker" worker # [ 78.923922] nix-daemon[956]: accepted connection from pid 1219, user tribuchet (trusted) hub # [ 89.448932] tribuchet[1170]: 2026-09-01T11:38:35.683399Z INFO tribuchet::hub::relay::staging: input path negotiation done id="5c39d4b87f0fd520e74527bdc674e981" total=7 missing=0 worker # [ 78.930118] tribuchet[1219]: 2026-09-01T11:38:34.566288Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="5c39d4b87f0fd520e74527bdc674e981" fixed_output=false network=false net_isolation=false worker # [ 78.995778] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:34.631969Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 79.001401] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:34.637654Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 79.006087] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:34.637732Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 79.010535] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:34.646952Z INFO tribuchet::worker::agent: builder started id="5c39d4b87f0fd520e74527bdc674e981" pid=1310 worker # [ 79.015347] tribuchet[1219]: 2026-09-01T11:38:34.648655Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="5c39d4b87f0fd520e74527bdc674e981" pid=1310 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/6054c92fcc43a424/build worker # [ 79.761757] tribuchet[1219]: 2026-09-01T11:38:35.397845Z INFO tribuchet::worker: handover requested; exiting hub # [ 90.284736] tribuchet[1170]: 2026-09-01T11:38:36.519074Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 90.288567] tribuchet[1170]: 2026-09-01T11:38:36.519201Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="5c39d4b87f0fd520e74527bdc674e981" worker # [ 79.798685] tribuchet[1349]: 2026-09-01T11:38:35.434807Z 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/3h7cnbgyb34y7c0al8cnarhv32984rxr-qemu-user-static-x86_64-unknown-linux-musl-11.1.0/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, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 79.816455] tribuchet[1349]: 2026-09-01T11:38:35.435289Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox") worker # [ 79.824604] tribuchet[1349]: 2026-09-01T11:38:35.460961Z INFO tribuchet::worker::resume: adopted running build id="5c39d4b87f0fd520e74527bdc674e981" pid=1310 worker # [ 79.833132] nix-daemon[956]: accepted connection from pid 1349, user tribuchet (trusted) worker # [ 79.847288] tribuchet[1349]: 2026-09-01T11:38:35.483737Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 90.366336] tribuchet[1170]: 2026-09-01T11:38:36.600333Z 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 # [ 79.852094] tribuchet[1349]: 2026-09-01T11:38:35.488358Z INFO tribuchet::worker::session: build resumed id="5c39d4b87f0fd520e74527bdc674e981" key="d32035daa89fde7141fe5672f7c58a3c2fe6231f73a929e2a8887ae8e2b58e95" hub # [ 90.374150] tribuchet[1170]: 2026-09-01T11:38:36.600553Z INFO tribuchet::hub: dispatching build id="5c39d4b87f0fd520e74527bdc674e981" worker="worker" hub # [ 90.378370] tribuchet[1170]: 2026-09-01T11:38:36.612575Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="5c39d4b87f0fd520e74527bdc674e981" worker # [ 93.366927] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:49.002907Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 93.367695] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:49.003023Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 93.454886] tribuchet[1349]: 2026-09-01T11:38:49.090922Z INFO tribuchet::worker::build::agent_exec: builder finished id="5c39d4b87f0fd520e74527bdc674e981" exit_code=0 aborted=None worker # [ 93.469843] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1304]: 2026-09-01T11:38:49.106284Z INFO tribuchet::worker::agent: cleanup done id="5c39d4b87f0fd520e74527bdc674e981" worker # [ 93.542665] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1375]: 2026-09-01T11:38:49.178756Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 93.548334] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1375]: 2026-09-01T11:38:49.181676Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 93.552781] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1375]: 2026-09-01T11:38:49.181716Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 93.557115] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1375]: 2026-09-01T11:38:49.181772Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 93.575349] tribuchet[1349]: 2026-09-01T11:38:49.211789Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="5c39d4b87f0fd520e74527bdc674e981" worker # [ 93.581218] tribuchet[1349]: 2026-09-01T11:38:49.217672Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="5c39d4b87f0fd520e74527bdc674e981" worker # [ 94.655570] systemd[1387]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 94.736911] systemd[1387]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 105.926367] tribuchet[1170]: 2026-09-01T11:38:52.160522Z INFO tribuchet::hub::submit: queueing build id="429aebbccb6a30b9e4c9762e956ffe02" system="x86_64-linux" worker # [ 95.408225] tribuchet[1349]: 2026-09-01T11:38:51.044197Z INFO tribuchet::worker::session: build assigned id="429aebbccb6a30b9e4c9762e956ffe02" hub # [ 105.930351] tribuchet[1170]: 2026-09-01T11:38:52.160578Z INFO tribuchet::hub: dispatching build id="429aebbccb6a30b9e4c9762e956ffe02" worker="worker" worker # [ 95.413723] nix-daemon[956]: accepted connection from pid 1349, user tribuchet (trusted) hub # [ 105.937665] tribuchet[1170]: 2026-09-01T11:38:52.172175Z INFO tribuchet::hub::relay::staging: input path negotiation done id="429aebbccb6a30b9e4c9762e956ffe02" total=7 missing=0 worker # [ 95.418227] tribuchet[1349]: 2026-09-01T11:38:51.054541Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="429aebbccb6a30b9e4c9762e956ffe02" fixed_output=false network=false net_isolation=false worker # [ 95.472165] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1433]: 2026-09-01T11:38:51.108350Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 95.478770] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1433]: 2026-09-01T11:38:51.111667Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 95.482829] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1433]: 2026-09-01T11:38:51.111704Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 95.491533] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1433]: 2026-09-01T11:38:51.127883Z INFO tribuchet::worker::agent: builder started id="429aebbccb6a30b9e4c9762e956ffe02" pid=1439 worker # [ 95.495875] tribuchet[1349]: 2026-09-01T11:38:51.127960Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="429aebbccb6a30b9e4c9762e956ffe02" pid=1439 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/a0d2ba526fefe760/build hub # [ 106.665468] systemd[1]: cancelbuild.service: Main process exited, code=killed, status=9/KILL hub # [ 106.668614] systemd[1]: cancelbuild.service: Failed with result 'signal'. [e2e] heartbeat t=90s worker # [ 107.409872] tribuchet[1349]: 2026-09-01T11:39:03.045921Z INFO tribuchet::worker::session: hub cancelled the build id="429aebbccb6a30b9e4c9762e956ffe02" hub # [ 117.928374] tribuchet[1170]: 2026-09-01T11:39:04.162190Z INFO tribuchet::hub::relay: no attach client left; cancelling build id="429aebbccb6a30b9e4c9762e956ffe02" worker # [ 107.513464] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1433]: 2026-09-01T11:39:03.149354Z INFO tribuchet::worker::agent: builder exited code=137 worker # [ 107.717169] tribuchet[1349]: 2026-09-01T11:39:03.353223Z INFO tribuchet::worker::build::agent_exec: builder finished id="429aebbccb6a30b9e4c9762e956ffe02" exit_code=137 aborted=Some("build cancelled") worker # [ 107.722685] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1433]: 2026-09-01T11:39:03.358287Z INFO tribuchet::worker::agent: cleanup done id="429aebbccb6a30b9e4c9762e956ffe02" worker # [ 107.784357] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1669]: 2026-09-01T11:39:03.420519Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 107.788611] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1669]: 2026-09-01T11:39:03.425085Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 107.789372] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1669]: 2026-09-01T11:39:03.425126Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 107.790201] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1669]: 2026-09-01T11:39:03.425181Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 107.836091] tribuchet[1349]: 2026-09-01T11:39:03.472461Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="429aebbccb6a30b9e4c9762e956ffe02" worker # [ 107.841910] tribuchet[1349]: 2026-09-01T11:39:03.478400Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="429aebbccb6a30b9e4c9762e956ffe02" hub # [ 118.886144] systemd[2064]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 119.038844] systemd[2064]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 108.971260] tribuchet[1349]: 2026-09-01T11:39:04.607324Z INFO tribuchet::worker::session: build assigned id="a273fbb1f1d4b51cb425fbeeaad8f3bb" hub # [ 119.490172] tribuchet[1170]: 2026-09-01T11:39:05.723554Z INFO tribuchet::hub::submit: queueing build id="a273fbb1f1d4b51cb425fbeeaad8f3bb" system="x86_64-linux" hub # [ 119.493532] tribuchet[1170]: 2026-09-01T11:39:05.723618Z INFO tribuchet::hub: dispatching build id="a273fbb1f1d4b51cb425fbeeaad8f3bb" worker="worker" worker # [ 108.977195] nix-daemon[956]: accepted connection from pid 1349, user tribuchet (trusted) hub # [ 119.501061] tribuchet[1170]: 2026-09-01T11:39:05.735584Z INFO tribuchet::hub::relay::staging: input path negotiation done id="a273fbb1f1d4b51cb425fbeeaad8f3bb" total=7 missing=0 worker # [ 108.981844] tribuchet[1349]: 2026-09-01T11:39:04.618206Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="a273fbb1f1d4b51cb425fbeeaad8f3bb" fixed_output=false network=false net_isolation=false worker # [ 109.054482] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1689]: 2026-09-01T11:39:04.690688Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 109.058781] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1689]: 2026-09-01T11:39:04.691607Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 109.062458] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1689]: 2026-09-01T11:39:04.691651Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 109.066444] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1689]: 2026-09-01T11:39:04.702623Z INFO tribuchet::worker::agent: builder started id="a273fbb1f1d4b51cb425fbeeaad8f3bb" pid=1695 worker # [ 109.070975] tribuchet[1349]: 2026-09-01T11:39:04.702712Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="a273fbb1f1d4b51cb425fbeeaad8f3bb" pid=1695 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/d8011d95de9843f5/build [e2e] heartbeat t=120s worker # [ 138.367152] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1689]: 2026-09-01T11:39:34.003022Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 138.498383] tribuchet[1349]: 2026-09-01T11:39:34.134408Z INFO tribuchet::worker::build::agent_exec: builder finished id="a273fbb1f1d4b51cb425fbeeaad8f3bb" exit_code=0 aborted=None worker # [ 138.509155] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1689]: 2026-09-01T11:39:34.145194Z INFO tribuchet::worker::agent: cleanup done id="a273fbb1f1d4b51cb425fbeeaad8f3bb" worker # [ 138.570777] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1712]: 2026-09-01T11:39:34.206626Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 138.574710] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1712]: 2026-09-01T11:39:34.206756Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 138.578135] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1712]: 2026-09-01T11:39:34.206788Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 138.581704] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1712]: 2026-09-01T11:39:34.206835Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 138.630180] tribuchet[1349]: 2026-09-01T11:39:34.266408Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="a273fbb1f1d4b51cb425fbeeaad8f3bb" worker # [ 138.635140] tribuchet[1349]: 2026-09-01T11:39:34.271560Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="a273fbb1f1d4b51cb425fbeeaad8f3bb" worker # [ 139.218480] tribuchet[1349]: 2026-09-01T11:39:34.854900Z INFO tribuchet::worker::session: build assigned id="47edbcb548df5518eea3409e7d5d6ea7" hub # [ 149.737594] tribuchet[1170]: 2026-09-01T11:39:35.971174Z INFO tribuchet::hub::submit: queueing build id="47edbcb548df5518eea3409e7d5d6ea7" system="x86_64-linux" worker # [ 139.224416] nix-daemon[956]: accepted connection from pid 1349, user tribuchet (trusted) hub # [ 149.744476] tribuchet[1170]: 2026-09-01T11:39:35.971246Z INFO tribuchet::hub: dispatching build id="47edbcb548df5518eea3409e7d5d6ea7" worker="worker" hub # [ 149.750623] tribuchet[1170]: 2026-09-01T11:39:35.985158Z INFO tribuchet::hub::relay::staging: input path negotiation done id="47edbcb548df5518eea3409e7d5d6ea7" total=7 missing=0 worker # [ 139.231477] tribuchet[1349]: 2026-09-01T11:39:34.867930Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="47edbcb548df5518eea3409e7d5d6ea7" fixed_output=false network=false net_isolation=false hub # [ 149.773111] tribuchet[1170]: 2026-09-01T11:39:36.006974Z INFO tribuchet::hub::submit: queueing build id="a32986ed753c88e317db0e6796e49264" system="x86_64-linux" worker # [ 139.254131] tribuchet[1349]: 2026-09-01T11:39:34.890522Z INFO tribuchet::worker::session: build assigned id="a32986ed753c88e317db0e6796e49264" worker # [ 139.260613] nix-daemon[956]: accepted connection from pid 1349, user tribuchet (trusted) hub # [ 149.777822] tribuchet[1170]: 2026-09-01T11:39:36.007044Z INFO tribuchet::hub: dispatching build id="a32986ed753c88e317db0e6796e49264" worker="worker" hub # [ 149.787490] tribuchet[1170]: 2026-09-01T11:39:36.022031Z INFO tribuchet::hub::relay::staging: input path negotiation done id="a32986ed753c88e317db0e6796e49264" total=7 missing=0 worker # [ 139.268322] tribuchet[1349]: 2026-09-01T11:39:34.904695Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="a32986ed753c88e317db0e6796e49264" fixed_output=false network=false net_isolation=false worker # [ 139.284639] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[917]: 2026-09-01T11:39:34.920937Z INFO tribuchet::worker::agent: builder started id="a32986ed753c88e317db0e6796e49264" pid=1727 worker # [ 139.288630] tribuchet[1349]: 2026-09-01T11:39:34.921097Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="a32986ed753c88e317db0e6796e49264" pid=1727 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/fe0b53a3800b6ed5/build worker # [ 139.313265] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1726]: 2026-09-01T11:39:34.949405Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 139.318242] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1726]: 2026-09-01T11:39:34.954712Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 139.324142] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1726]: 2026-09-01T11:39:34.954762Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 139.335432] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1726]: 2026-09-01T11:39:34.971886Z INFO tribuchet::worker::agent: builder started id="47edbcb548df5518eea3409e7d5d6ea7" pid=1737 worker # [ 139.341199] tribuchet[1349]: 2026-09-01T11:39:34.977682Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="47edbcb548df5518eea3409e7d5d6ea7" pid=1737 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/584f05d91d999426/build worker # [ 153.376211] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[917]: 2026-09-01T11:39:49.012193Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 153.379501] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1726]: 2026-09-01T11:39:49.012714Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 153.496641] tribuchet[1349]: 2026-09-01T11:39:49.132679Z INFO tribuchet::worker::build::agent_exec: builder finished id="a32986ed753c88e317db0e6796e49264" exit_code=0 aborted=None worker # [ 153.504128] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[917]: 2026-09-01T11:39:49.140296Z INFO tribuchet::worker::agent: cleanup done id="a32986ed753c88e317db0e6796e49264" worker # [ 153.560048] tribuchet[1349]: 2026-09-01T11:39:49.196484Z INFO tribuchet::worker::build::agent_exec: builder finished id="47edbcb548df5518eea3409e7d5d6ea7" exit_code=0 aborted=None worker # [ 153.565689] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1750]: 2026-09-01T11:39:49.201726Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 153.566240] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1750]: 2026-09-01T11:39:49.201848Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 153.566945] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1750]: 2026-09-01T11:39:49.201874Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 153.567800] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1750]: 2026-09-01T11:39:49.201911Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 153.584230] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1726]: 2026-09-01T11:39:49.220712Z INFO tribuchet::worker::agent: cleanup done id="47edbcb548df5518eea3409e7d5d6ea7" worker # [ 153.599924] tribuchet[1349]: 2026-09-01T11:39:49.236234Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="a32986ed753c88e317db0e6796e49264" worker # [ 153.605491] tribuchet[1349]: 2026-09-01T11:39:49.241971Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="a32986ed753c88e317db0e6796e49264" worker # [ 153.655479] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1762]: 2026-09-01T11:39:49.291708Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 153.660330] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1762]: 2026-09-01T11:39:49.296727Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 153.661096] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1762]: 2026-09-01T11:39:49.296769Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 153.661846] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1762]: 2026-09-01T11:39:49.296837Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 153.664252] tribuchet[1349]: 2026-09-01T11:39:49.300676Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="47edbcb548df5518eea3409e7d5d6ea7" worker # [ 153.678469] tribuchet[1349]: 2026-09-01T11:39:49.314958Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="47edbcb548df5518eea3409e7d5d6ea7" worker # [ 153.893934] systemd[1774]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 153.966684] systemd[1774]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 164.947513] tribuchet[1170]: 2026-09-01T11:39:51.181323Z INFO tribuchet::hub::submit: queueing build id="694f73655af411c30be6e73965af94e3" system="x86_64-linux" worker # [ 154.428587] tribuchet[1349]: 2026-09-01T11:39:50.064865Z INFO tribuchet::worker::session: build assigned id="694f73655af411c30be6e73965af94e3" hub # [ 164.951185] tribuchet[1170]: 2026-09-01T11:39:51.181381Z INFO tribuchet::hub: dispatching build id="694f73655af411c30be6e73965af94e3" worker="worker" worker # [ 154.435890] nix-daemon[956]: accepted connection from pid 1349, user tribuchet (trusted) hub # [ 164.966708] tribuchet[1170]: 2026-09-01T11:39:51.201243Z INFO tribuchet::hub::relay::staging: input path negotiation done id="694f73655af411c30be6e73965af94e3" total=7 missing=0 worker # [ 154.447456] tribuchet[1349]: 2026-09-01T11:39:50.083920Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="694f73655af411c30be6e73965af94e3" fixed_output=false network=false net_isolation=false worker # [ 154.539348] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:39:50.175532Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 154.544037] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:39:50.180499Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 154.544675] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:39:50.180538Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 154.562097] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:39:50.196903Z INFO tribuchet::worker::agent: builder started id="694f73655af411c30be6e73965af94e3" pid=1825 worker # [ 154.566175] tribuchet[1349]: 2026-09-01T11:39:50.198714Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="694f73655af411c30be6e73965af94e3" pid=1825 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/25e059e7b1e062af/build worker # [ 155.122587] tribuchet[1349]: 2026-09-01T11:39:50.758067Z INFO tribuchet::worker: handover requested; exiting hub # [ 165.644721] tribuchet[1170]: 2026-09-01T11:39:51.879039Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 165.648677] tribuchet[1170]: 2026-09-01T11:39:51.879098Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="694f73655af411c30be6e73965af94e3" hub # [ 168.645960] tribuchet[1170]: 2026-09-01T11:39:54.880082Z WARN tribuchet::hub::state: failing queued build: last capable worker left id="694f73655af411c30be6e73965af94e3" hub # [ 169.834543] tribuchet[1170]: 2026-09-01T11:39:56.068284Z INFO tribuchet::hub::submit: no capable worker; declining system="x86_64-linux" worker # [ 159.861872] tribuchet[1869]: 2026-09-01T11:39:55.498119Z 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/3h7cnbgyb34y7c0al8cnarhv32984rxr-qemu-user-static-x86_64-unknown-linux-musl-11.1.0/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, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 159.881504] tribuchet[1869]: 2026-09-01T11:39:55.505139Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox") worker # [ 159.886506] tribuchet[1869]: 2026-09-01T11:39:55.510778Z INFO tribuchet::worker::resume: adopted running build id="694f73655af411c30be6e73965af94e3" pid=1825 worker # [ 159.898339] nix-daemon[956]: accepted connection from pid 1869, user tribuchet (trusted) worker # [ 159.981487] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1883]: 2026-09-01T11:39:55.617706Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 159.986615] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1883]: 2026-09-01T11:39:55.623110Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 159.990944] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1883]: 2026-09-01T11:39:55.627442Z INFO tribuchet::worker::agent: agent listening uid=65504 hub # [ 170.518454] tribuchet[1170]: 2026-09-01T11:39:56.752943Z 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.039850] tribuchet[1869]: 2026-09-01T11:39:55.676189Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 170.890391] tribuchet[1170]: 2026-09-01T11:39:57.124530Z INFO tribuchet::hub::submit: queueing build id="ffa2c490f809e706caf4bac4c19962ad" system="x86_64-linux" hub # [ 170.894965] tribuchet[1170]: 2026-09-01T11:39:57.124597Z INFO tribuchet::hub: dispatching build id="ffa2c490f809e706caf4bac4c19962ad" worker="worker" worker # [ 160.376485] tribuchet[1869]: 2026-09-01T11:39:56.012829Z INFO tribuchet::worker::session: build resumed id="ffa2c490f809e706caf4bac4c19962ad" key="a33d2f10183b95c8bedbaed894782ece8edff4dd5e623a71d71ec38ef3de1c0b" hub # [ 170.901351] tribuchet[1170]: 2026-09-01T11:39:57.135915Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="ffa2c490f809e706caf4bac4c19962ad" [e2e] heartbeat t=150s worker # [ 184.366454] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:40:20.002253Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 184.367168] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:40:20.002453Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 184.531764] tribuchet[1869]: 2026-09-01T11:40:20.167841Z INFO tribuchet::worker::build::agent_exec: builder finished id="694f73655af411c30be6e73965af94e3" exit_code=0 aborted=None worker # [ 184.544248] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1819]: 2026-09-01T11:40:20.180685Z INFO tribuchet::worker::agent: cleanup done id="694f73655af411c30be6e73965af94e3" worker # [ 184.620248] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1900]: 2026-09-01T11:40:20.256430Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 184.624444] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1900]: 2026-09-01T11:40:20.257250Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 184.628042] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1900]: 2026-09-01T11:40:20.257279Z INFO tribuchet::worker::agent: agent listening uid=61629 worker # [ 184.631822] 9bj622536annqvqzxzxv1807gmdlv27j-tribuchet-agent[1900]: 2026-09-01T11:40:20.257320Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 184.635600] tribuchet[1869]: 2026-09-01T11:40:20.264292Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="ffa2c490f809e706caf4bac4c19962ad" worker # [ 184.638967] tribuchet[1869]: 2026-09-01T11:40:20.271815Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="ffa2c490f809e706caf4bac4c19962ad" worker # [ 185.038319] systemd[1912]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 185.116878] systemd[1912]: 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 169.36s (finished: subtest: daemon lifecycle, in 169.37 seconds) (finished: run the VM test script, in 198.25 seconds) test script finished in 198.29s cleanup kill QemuMachine (pid 54) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) kill QemuMachine (pid 55) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.41 seconds)