Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.03 seconds) start vhost-device-vsock (finished: start vhost-device-vsock, in 0.01 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/tmp4osgotte/hub_host.socket worker: ssh -o User=root vsock-mux//build/tmp4osgotte/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.lYnArmm7lo', 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: 15f00a32-7fbb-4a20-ba42-93fe607e9777 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 55) 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[ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 9 18:25:30 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/9xy24kn07n2009wqpzcwkd2avdydspg2-nixos-system-hub-test/init regInfo=/nix/store/kg86nnqwzzw801sfihmjihml6dz23090-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 1804329043 cycles hub # [ 0.000004] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000011] tsc: Detected 3099.998 MHz processor hub # [ 0.001753] last_pfn = 0x180000 max_arch_pfn = 0x400000000 hub # [ 0.001800] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.001804] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.001868] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.004221] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.004259] Using GB pages for direct mapping hub # [ 0.004408] RAMDISK: [mem 0x7e34e000-0x7ffcffff] hub # [ 0.004419] ACPI: Early table checksum verification disabled hub # [ 0.004426] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) hub # [ 0.004432] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004440] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004449] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004452] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.004455] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004457] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004459] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004461] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004463] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] hub # [ 0.004465] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] hub # [ 0.004466] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.004466] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] hub # [ 0.004467] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] hub # [ 0.004467] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] hub # [ 0.004468] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] hub # [ 0.005043] No NUMA configuration found hub # [ 0.005045] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] hub # [ 0.005050] NODE_DATA(0) allocated [mem 0x17fff8780-0x17fffdcff] hub # [ 0.005180] Zone ranges: hub # [ 0.005181] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005183] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] hub # [ 0.005185] Normal [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005186] Device empty hub # [ 0.005187] Movable zone start for each node hub # [ 0.005188] Early memory node ranges hub # [ 0.005189] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005190] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.005191] node 0: [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005193] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] hub # [ 0.005225] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.005656] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.166952] On node 0, zone Normal: 40 pages in unavailable ranges hub # [ 0.168781] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.168804] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.168844] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.168849] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.168851] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.168853] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.168855] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.168856] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.168860] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.168862] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.168869] TSC deadline timer available hub # [ 0.168876] CPU topo: Max. logical packages: 1 hub # [ 0.168877] CPU topo: Max. logical dies: 1 hub # [ 0.168878] CPU topo: Max. dies per package: 1 hub # [ 0.168974] CPU topo: Max. threads per core: 1 hub # [ 0.168976] CPU topo: Num. cores per package: 1 hub # [ 0.168977] CPU topo: Num. threads per package: 1 hub # [ 0.168977] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.169008] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.169055] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.169057] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.169059] PM: hibernation: Registered nosave memory: [mem 0x7ffd8000-0xffffffff] hub # [ 0.169061] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.169063] Booting paravirtualized kernel on KVM hub # [ 0.169069] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.176061] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.180717] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.180816] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.180819] 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/9xy24kn07n2009wqpzcwkd2avdydspg2-nixos-system-hub-test/init regInfo=/nix/store/kg86nnqwzzw801sfihmjihml6dz23090-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.181052] Unknown kernel command line parameters "regInfo=/nix/store/kg86nnqwzzw801sfihmjihml6dz23090-closure-info/registration", will be passed to user space. hub # [ 0.181079] random: crng init done hub # [ 0.181080] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.188749] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) hub # [ 0.193100] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.193163] software IO TLB: area num 1. hub # [ 0.323211] Fallback order for Node 0: 0 hub # [ 0.323222] Built 1 zonelists, mobility grouping on. Total pages: 1048438 hub # [ 0.323225] Policy zone: Normal hub # [ 0.327459] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.350508] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.364298] allocated 8388608 bytes of page_ext hub # [ 0.378646] ftrace: allocating 48717 entries in 192 pages hub # [ 0.378653] ftrace: allocated 192 pages with 2 groups hub # [ 0.379908] Dynamic Preempt: lazy hub # [ 0.380149] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.380150] rcu: RCU event tracing is enabled. hub # [ 0.380150] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.380153] Trampoline variant of Tasks RCU enabled. hub # [ 0.380154] Rude variant of Tasks RCU enabled. hub # [ 0.380154] Tracing variant of Tasks RCU enabled. hub # [ 0.380155] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.380156] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.380180] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.380182] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.380184] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.386519] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.386880] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.386889] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.387039] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.395311] Console: colour VGA+ 80x25 hub # [ 0.395323] printk: legacy console [tty0] enabled hub # [ 0.449183] printk: legacy console [ttyS0] enabled hub # [ 0.690166] ACPI: Core revision 20250807 hub # [ 0.694365] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.704891] APIC: Switch to symmetric I/O mode setup hub # [ 0.708316] x2apic enabled hub # [ 0.711762] APIC: Switched APIC routing to: physical x2apic hub # [ 0.720999] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.730541] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.735654] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) hub # [ 0.737785] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.740110] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.742652] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.744673] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.746665] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.748657] Spectre V2 : Mitigation: Retpolines hub # [ 0.749658] RETBleed: Mitigation: untrained return thunk hub # [ 0.751651] Speculative Return Stack Overflow: Mitigation: SMT disabled hub # [ 0.753653] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.754664] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT hub # [ 0.756643] Spectre V2 : Enabling Speculation Barrier for firmware calls hub # [ 0.756643] active return thunk: retbleed_return_thunk hub # [ 0.757659] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.759682] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.761652] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.762660] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.763660] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.765651] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. hub # [ 0.809952] Freeing SMP alternatives memory: 44K hub # [ 0.810661] pid_max: default: 32768 minimum: 301 hub # [ 0.811768] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.813797] landlock: Up and running. hub # [ 0.814643] Yama: becoming mindful. hub # [ 0.815944] LSM support for eBPF active hub # [ 0.816643] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.817769] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.821643] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) hub # [ 0.823643] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.824657] ... version: 0 hub # [ 0.826655] ... bit width: 48 hub # [ 0.827666] ... generic counters: 6 hub # [ 0.828659] ... generic bitmap: 000000000000003f hub # [ 0.829653] ... fixed-purpose counters: 0 hub # [ 0.830653] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.832030] ... value mask: 0000ffffffffffff hub # [ 0.832661] ... max period: 00007fffffffffff hub # [ 0.833668] ... global_ctrl mask: 000000000000003f hub # [ 0.834784] signal: max sigframe size: 1776 hub # [ 0.835893] rcu: Hierarchical SRCU implementation. hub # [ 0.836668] rcu: Max phase no-delay instances is 400. hub # [ 0.843495] smp: Bringing up secondary CPUs ... hub # [ 0.844682] smp: Brought up 1 node, 1 CPU hub # [ 0.846522] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) hub # [ 0.848129] Memory: 3961740K/4193752K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 217772K reserved, 0K cma-reserved) hub # [ 0.850886] devtmpfs: initialized hub # [ 0.851935] x86/mm: Memory block size: 128MB hub # [ 0.854774] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.855731] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.857368] pinctrl core: initialized pinctrl subsystem hub # [ 0.860061] PM: RTC time: 17:26:16, date: 2026-08-30 hub # [ 0.864998] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.867744] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.868796] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.870454] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.871708] audit: initializing netlink subsys (disabled) hub # [ 0.873214] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.873217] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.873675] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.874684] audit: type=2000 audit(1788110776.476:1): state=initialized audit_enabled=0 res=1 hub # [ 0.876679] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.876692] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.877727] cpuidle: using governor menu hub # [ 0.881573] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.883130] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.884667] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.885690] PCI: Using configuration type 1 for base access hub # [ 0.888067] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.896113] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.896658] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.897662] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.904670] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.914612] ACPI: Added _OSI(Module Device) hub # [ 0.915638] ACPI: Added _OSI(Processor Device) hub # [ 0.922664] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.930517] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.941570] ACPI: Interpreter enabled hub # [ 0.942636] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.943610] ACPI: Using IOAPIC for interrupt routing hub # [ 0.946874] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.947657] PCI: Using E820 reservations for host bridge windows hub # [ 0.950987] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.959857] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.960672] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.961774] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.962801] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.964347] PCI host bridge to bus 0000:00 hub # [ 0.965573] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.966659] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.967678] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.968670] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.969663] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.971664] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.973664] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.974984] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.977151] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.981804] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.982689] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.983722] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.984981] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.988241] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.993691] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.995691] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.996720] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] hub # [ 0.998687] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 1.001934] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 1.005686] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] hub # [ 1.006670] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 1.007718] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] hub # [ 1.010613] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 1.013860] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 1.014706] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 1.015729] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] hub # [ 1.019451] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 1.024098] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] hub # [ 1.024682] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 1.025752] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] hub # [ 1.028738] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 1.031693] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 1.032680] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 1.033722] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] hub # [ 1.036196] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 1.039684] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] hub # [ 1.040777] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 1.041889] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] hub # [ 1.044603] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 1.048686] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 1.049679] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 1.050698] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] hub # [ 1.051689] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 1.054516] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 1.057705] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 1.058712] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] hub # [ 1.062523] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 1.067686] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 1.068686] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 1.070733] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] hub # [ 1.073426] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 1.076687] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] hub # [ 1.077670] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 1.078705] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] hub # [ 1.081102] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint hub # [ 1.083690] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] hub # [ 1.084729] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 1.087176] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 1.090727] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] hub # [ 1.092791] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 1.095725] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] hub # [ 1.098179] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 1.101723] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] hub # [ 1.103373] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 1.106671] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] hub # [ 1.108262] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 1.110380] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 1.112484] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 1.115730] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] hub # [ 1.116677] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] hub # [ 1.118375] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 1.121427] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 1.130253] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 1.130855] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 1.131856] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 1.132830] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 1.133823] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 1.134794] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 1.135842] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 1.136838] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 1.137724] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 1.138694] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 1.139696] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 1.140684] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 1.141693] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 1.142706] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 1.143689] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 1.144760] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 1.148259] iommu: Default domain type: Translated hub # [ 1.149670] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 1.151186] ACPI: bus type USB registered hub # [ 1.151760] usbcore: registered new interface driver usbfs hub # [ 1.152730] usbcore: registered new interface driver hub hub # [ 1.153685] usbcore: registered new device driver usb hub # [ 1.156009] NetLabel: Initializing hub # [ 1.156651] NetLabel: domain hash size = 128 hub # [ 1.157650] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 1.158722] NetLabel: unlabeled traffic allowed by default hub # [ 1.159670] PCI: Using ACPI for IRQ routing hub # [ 1.277429] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 1.277643] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 1.277643] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 1.277672] vgaarb: loaded hub # [ 1.278913] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 1.279653] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 1.282856] clocksource: Switched to clocksource kvm-clock hub # [ 1.289910] VFS: Disk quotas dquot_6.6.0 hub # [ 1.291576] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 1.296128] pnp: PnP ACPI init hub # [ 1.299521] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 1.301189] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 1.309743] pnp: PnP ACPI: found 6 devices hub # [ 1.322075] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 1.325352] clocksource: Switched to clocksource acpi_pm hub # [ 1.327318] NET: Registered PF_INET protocol family hub # [ 1.330726] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) hub # [ 1.359190] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) hub # [ 1.362114] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 1.365129] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 1.370158] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) hub # [ 1.372609] TCP: Hash tables configured (established 32768 bind 32768) hub # [ 1.375354] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) hub # [ 1.377535] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 1.380406] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 1.383101] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 1.384965] NET: Registered PF_XDP protocol family hub # [ 1.387069] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 1.388867] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 1.391591] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 1.394207] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 1.396957] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 1.399304] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] hub # [ 1.403526] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 1.406533] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 1.409740] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 1.412761] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 1.418731] PCI: CLS 0 bytes, default 64 hub # [ 1.422377] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) hub # [ 1.425474] Trying to unpack rootfs image as initramfs... hub # [ 1.434856] software IO TLB: mapped [mem 0x000000007a34e000-0x000000007e34e000] (64MB) hub # [ 1.442922] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 1.560714] Initialise system trusted keyrings hub # [ 1.567835] workingset: timestamp_bits=40 max_order=20 bucket_order=0 hub # [ 1.612842] Key type asymmetric registered hub # [ 1.614480] Asymmetric key parser 'x509' registered hub # [ 1.620918] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 1.633094] io scheduler mq-deadline registered hub # [ 1.635005] io scheduler kyber registered hub # [ 1.641463] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 1.648867] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 1.657479] Linux agpgart interface v0.103 hub # [ 1.661026] ACPI: bus type drm_connector registered hub # [ 1.668684] usbcore: registered new interface driver usbserial_generic hub # [ 1.673960] usbserial: USB Serial support registered for generic hub # [ 1.676364] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 1.684320] drop_monitor: Initializing network drop monitor service hub # [ 1.690932] NET: Registered PF_INET6 protocol family hub # [ 1.697059] Segment Routing with IPv6 hub # [ 1.702000] In-situ OAM (IOAM) with IPv6 hub # [ 1.704650] IPI shorthand broadcast: enabled hub # [ 1.714322] sched_clock: Marking stable (1372037006, 341755343)->(2195378128, -481585779) hub # [ 1.733017] registered taskstats version 1 hub # [ 1.735290] Loading compiled-in X.509 certificates hub # [ 1.761827] Demotion targets for Node 0: null hub # [ 1.763456] Key type .fscrypt registered hub # [ 1.766818] Key type fscrypt-provisioning registered hub # [ 1.771928] ima: No TPM chip found, activating TPM-bypass! hub # [ 1.773621] ima: Allocated hash algorithm: sha1 hub # [ 1.776896] ima: No architecture policies found hub # [ 1.781832] PM: Magic number: 6:446:442 hub # [ 1.787188] RAS: Correctable Errors collector initialized. hub # [ 1.809258] clk: Disabling unused clocks hub # [ 1.810679] PM: genpd: Disabling unused power domains hub # [ 2.263650] Freeing initrd memory: 29192K hub # [ 2.271223] Freeing unused decrypted memory: 2028K hub # [ 2.277547] Freeing unused kernel image (initmem) memory: 3644K hub # [ 2.280001] Write protecting the kernel read-only data: 32768k hub # [ 2.284904] Freeing unused kernel image (text/rodata gap) memory: 1220K hub # [ 2.289611] Freeing unused kernel image (rodata/data gap) memory: 756K hub # [ 2.343391] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 2.345722] Run /init as init process hub # [ 2.367884] systemd[1]: Inserted module 'autofs4' hub # [ 2.395913] fuse: init (API version 7.45) hub # [ 2.406329] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 2.411116] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 2.416697] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 2.421206] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 2.471855] systemd[1]: Successfully made /usr/ read-only. hub # [ 2.813556] systemd[1]: systemd 261.1 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.823809] systemd[1]: Detected virtualization kvm. hub # [ 2.825272] systemd[1]: Detected architecture x86-64. hub # [ 2.826692] systemd[1]: Running in initrd. hub # [ 2.828368] systemd[1]: Initializing machine ID from random generator. hub # [ 2.830328] systemd[1]: Hostname set to . hub # [ 3.048687] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 3.225460] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 3.244565] systemd[1]: Created slice Slice /system/modprobe. hub # [ 3.263584] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 3.274633] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 3.279621] systemd[1]: Reached target Path Units. hub # [ 3.281091] systemd[1]: Reached target Slice Units. hub # [ 3.283207] systemd[1]: Reached target Swaps. hub # [ 3.285088] systemd[1]: Reached target Timer Units. hub # [ 3.286890] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 3.289135] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 3.291268] systemd[1]: Listening on Journal Sockets. hub # [ 3.293307] systemd[1]: Listening on udev Control Socket. hub # [ 3.295679] systemd[1]: Listening on udev Kernel Socket. hub # [ 3.297685] systemd[1]: Reached target Socket Units. hub # [ 3.301509] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 3.311167] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 3.328307] systemd[1]: Starting Load Kernel Module configfs... hub # [ 3.349237] systemd[1]: Starting Journal Service... hub # [ 3.371988] systemd[1]: Starting Load Kernel Modules... hub # [ 3.402201] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 3.406258] netfs: FS-Cache loaded hub # [ 3.433461] 9pnet: Installing 9P2000 support hub # [ 3.459073] systemd[1]: Starting Coldplug All udev Devices... hub # [ 3.533013] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 3.564478] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 3.624517] systemd-journald[68]: Collecting audit messages is disabled. hub # [ 3.629180] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 3.646558] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 3.662718] systemd[1]: Finished Load Kernel Module configfs. hub # [ 3.680557] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 3.686347] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 3.702006] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 3.713072] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 3.788044] systemd[1]: Finished Load Kernel Modules. hub # [ 3.810190] systemd[1]: Starting Apply Kernel Variables... hub # [ 3.841960] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 3.865318] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 3.898171] systemd[1]: Finished Apply Kernel Variables. hub # [ 3.936935] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 3.944363] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 3.955103] systemd[1]: Reached target Local File Systems. hub # [ 3.969730] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 3.989868] systemd[1]: Started Journal Service. hub # [ 3.651490] systemd-modules-load[69]: Inserted module 'dm_mod' hub # [ 3.656277] systemd-modules-load[69]: Inserted module 'virtio_balloon' hub # [ 3.659652] systemd-modules-load[69]: Inserted module 'virtio_gpu' hub # [ 3.704330] systemd[1]: Starting Create System Files and Directories... hub # [ 3.796614] systemd[1]: Finished Create System Files and Directories. hub # [ 3.803731] systemd-udevd[75]: Using default interface naming scheme 'v261'. hub # [ 3.853228] systemd[1]: Finished Coldplug All udev Devices. hub # [ 3.855649] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 3.859794] systemd[1]: Reached target System Initialization. hub # [ 3.863176] systemd[1]: Reached target Basic System. hub # [ 4.798940] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 4.823917] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 4.852625] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 4.861926] virtio_blk virtio5: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) hub # [ 4.888536] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 4.925646] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 4.928121] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 4.934608] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 hub # [ 4.944891] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 4.954105] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 4.956000] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 4.961280] usb usb1: Product: EHCI Host Controller hub # [ 4.964779] usb usb1: Manufacturer: Linux 6.18.44 ehci_hcd hub # [ 4.967446] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 4.969871] hub 1-0:1.0: USB hub found hub # [ 4.972119] hub 1-0:1.0: 6 ports detected hub # [ 4.978840] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 4.980120] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 5.003587] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 5.025697] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 hub # [ 5.049133] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 5.051052] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 5.061261] SCSI subsystem initialized hub # [ 4.754621] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. hub # [ 4.762009] systemd[1]: Starting Virtual Console Setup... hub # [ 5.115866] usb usb2: Product: UHCI Host Controller hub # [ 4.798159] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 4.803634] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. hub # [ 5.159067] usb usb2: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 5.167997] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 5.208922] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 5.216796] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 4.883559] systemd-vconsole-setup[107]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 4.892263] systemd[1]: Finished Virtual Console Setup. hub # [ 5.243861] hub 2-0:1.0: USB hub found hub # [ 5.256776] hub 2-0:1.0: 2 ports detected hub # [ 5.283980] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 5.285423] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 5.299050] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 5.308993] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 hub # [ 4.979185] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 4.982565] systemd[1]: Reached target Initrd Root Device. hub # [ 5.326854] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 5.330226] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 4.993118] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 5.368556] usb usb3: Product: UHCI Host Controller hub # [ 5.372539] usb usb3: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 5.387779] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 5.390551] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 5.395152] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 5.408420] usb 1-1: Product: QEMU USB Tablet hub # [ 5.412362] hub 3-0:1.0: USB hub found hub # [ 5.417821] usb 1-1: Manufacturer: QEMU hub # [ 5.424811] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 5.463779] hub 3-0:1.0: 2 ports detected hub # [ 5.495412] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 5.530514] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 5.572816] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 5.605222] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 hub # [ 5.274925] systemd-fsck[116]: nixos: clean, 12/262144 files, 37198/1048576 blocks[ 5.619447] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # hub # [ 5.623931] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 5.626637] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 5.633773] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 5.637765] usb usb4: Product: UHCI Host Controller hub # [ 5.639897] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 5.642766] usb usb4: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 5.650301] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 5.313507] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 5.323271] systemd[1]: Mounting /sysroot... hub # [ 5.670998] scsi host0: ahci hub # [ 5.673859] hub 4-0:1.0: USB hub found hub # [ 5.679012] hid: raw HID events driver (C) Jiri Kosina hub # [ 5.686793] hub 4-0:1.0: 2 ports detected hub # [ 5.693941] scsi host1: ahci hub # [ 5.704017] scsi host2: ahci hub # [ 5.717920] scsi host3: ahci hub # [ 5.731030] scsi host4: ahci hub # [ 5.760483] scsi host5: ahci hub # [ 5.767985] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 44 lpm-pol 1 hub # [ 5.800889] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 44 lpm-pol 1 hub # [ 5.812102] usbcore: registered new interface driver usbhid hub # [ 5.833965] usbhid: USB HID core driver hub # [ 5.839419] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 44 lpm-pol 1 hub # [ 5.868803] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 44 lpm-pol 1 hub # [ 5.896807] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 44 lpm-pol 1 hub # [ 5.916615] 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 # [ 5.926633] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 44 lpm-pol 1 hub # [ 5.938694] 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 # [ 6.069102] EXT4-fs (vda): mounted filesystem 15f00a32-7fbb-4a20-ba42-93fe607e9777 r/w with ordered data mode. Quota mode: none. hub # [ 5.734833] systemd[1]: Mounted /sysroot. hub # [ 5.737952] systemd[1]: Reached target Initrd Root File System. hub # [ 5.744160] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 5.750340] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 5.760143] systemd[1]: Mounting /sysroot/run... hub # [ 5.769096] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 5.786367] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 5.800548] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 6.179897] 9p: Installing v9fs 9p2000 file system support hub # [ 5.851171] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 5.875849] systemd[1]: Mounted /sysroot/run. hub # [ 5.878404] systemd-sysroot-fstab-check[152]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 5.893120] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 6.237947] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 6.240092] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 6.241821] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 6.243486] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 6.247642] ata3.00: applying bridge limits hub # [ 6.253008] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 6.254761] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 6.256930] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 6.259047] ata3.00: configured for UDMA/100 hub # [ 6.260818] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 5.926759] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 5.935198] systemd[1]: Reload requested from client PID 152 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 5.938222] systemd[1]: Reloading... hub # [ 6.433093] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 6.445771] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 6.194724] systemd[1]: Reloading finished in 252 ms. hub # [ 6.224671] systemd-sysroot-fstab-check[152]: Requesting initrd-fs.target/start/replace... hub # [ 6.236759] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 6.263147] systemd-sysroot-fstab-check[152]: Requesting swap.target/start/replace... hub # [ 6.270446] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 6.286885] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 6.293155] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 6.296567] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 6.315590] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 6.320239] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 6.326192] systemd[1]: Mounting /sysroot/nix/store... hub # [ 6.369517] systemd[1]: Mounted /sysroot/nix/store. hub # [ 6.373299] systemd[1]: Reached target Initrd File Systems. hub # [ 6.378265] systemd[1]: Starting Find NixOS closure... hub # [ 6.384379] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 6.450930] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 6.456412] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 6.472634] systemd[1]: Finished Find NixOS closure. hub # [ 6.477652] systemd[1]: Reached target Initrd Default Target. hub # [ 6.483367] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 6.510633] systemd[1]: Stopped target Initrd Default Target. hub # [ 6.512959] systemd[1]: Stopped target Basic System. hub # [ 6.514958] systemd[1]: Stopped target Initrd Root Device. hub # [ 6.519314] systemd[1]: Stopped target Path Units. hub # [ 6.520884] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 6.522746] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 6.524719] systemd[1]: Stopped target Slice Units. hub # [ 6.526704] systemd[1]: Stopped target Socket Units. hub # [ 6.528795] systemd[1]: Stopped target System Initialization. hub # [ 6.530920] systemd[1]: Stopped target Swaps. hub # [ 6.532996] systemd[1]: Stopped target Timer Units. hub # [ 6.535286] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 6.537199] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 6.539378] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 6.542284] systemd[1]: Stopped Find NixOS closure. hub # [ 6.544061] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 6.549343] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 6.552308] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 6.554357] systemd[1]: Stopped Apply Kernel Variables. hub # [ 6.555834] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 6.559297] systemd[1]: Stopped Load Kernel Modules. hub # [ 6.560816] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 6.562842] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 6.566545] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 6.570242] systemd[1]: Stopped Create System Files and Directories. hub # [ 6.572137] systemd[1]: Stopped target Local File Systems. hub # [ 6.574331] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 6.576763] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 6.579765] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 6.584256] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 6.586350] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 6.589829] systemd[1]: Stopped Virtual Console Setup. hub # [ 6.607554] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 6.615809] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 6.624197] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 6.628150] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 6.631247] systemd[1]: systemd-udevd.service: Consumed 1.034s CPU time over 2.998s wall clock time, 25.5M memory peak. hub # [ 6.633934] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 6.636914] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 6.640931] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 6.643881] systemd[1]: Closed udev Control Socket. hub # [ 6.652101] systemd[1]: Starting Cleanup udev Database... hub # [ 6.653749] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 6.659388] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 6.666466] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 6.672315] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 6.677327] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 6.679496] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 6.730506] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 6.734439] systemd[1]: Finished Cleanup udev Database. hub # [ 6.738200] systemd[1]: Reached target Switch Root. hub # [ 6.742467] systemd[1]: Starting NixOS Activation... hub # [ 7.610281] initrd-nixos-activation-start[202]: booting system configuration /nix/store/9xy24kn07n2009wqpzcwkd2avdydspg2-nixos-system-hub-test hub # [ 7.742328] initrd-nixos-activation-start[202]: running activation script... hub # [ 8.963345] initrd-nixos-activation-start[225]: setting up /etc... hub # [ 9.900559] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 9.905210] systemd[1]: Finished NixOS Activation. hub # [ 9.912396] systemd[1]: Starting Switch Root... hub # [ 9.958117] systemd[1]: Switching root. hub # [ 10.465924] systemd-journald[68]: Received SIGTERM from PID 1 (systemd). hub # [ 11.007798] NET: Registered PF_VSOCK protocol family hub # [ 11.699210] systemd[1]: systemd 261.1 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 # [ 11.724016] systemd[1]: Detected virtualization kvm. hub # [ 11.729710] systemd[1]: Detected architecture x86-64. hub # [ 11.735073] systemd[1]: Detected first boot. hub # [ 11.759289] systemd[1]: Initializing machine ID from random generator. hub # [ 12.314857] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 12.936379] systemd[1]: Applying preset policy. hub # [ 13.398867] systemd[1]: Populated /etc with preset unit settings. hub # [ 14.280909] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 14.283034] systemd[1]: Stopped initrd-switch-root.service. hub # [ 14.286925] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 14.290251] systemd[1]: Created slice Slice /system/getty. hub # [ 14.292471] systemd[1]: Created slice User and Session Slice. hub # [ 14.293938] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 14.295915] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 14.297599] systemd[1]: Expecting device /dev/hvc0... hub # [ 14.298800] systemd[1]: Expecting device /dev/ttyS0... hub # [ 14.299998] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 14.301465] systemd[1]: Stopped target initrd-fs.target. hub # [ 14.302845] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 14.304146] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 14.305547] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 14.307158] systemd[1]: Reached target Path Units. hub # [ 14.308309] systemd[1]: Reached target Remote File Systems. hub # [ 14.309498] systemd[1]: Reached target Slice Units. hub # [ 14.310618] systemd[1]: Reached target Swaps. hub # [ 14.314977] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 14.319997] systemd[1]: Listening on Process Core Dump Socket. hub # [ 14.323474] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 14.326779] systemd[1]: Listening on Factory Reset Management. hub # [ 14.328169] systemd[1]: Listening on Hostname Service Socket. hub # [ 14.333578] systemd[1]: Starting Journal Log Access Socket... hub # [ 14.335992] systemd[1]: Listening on Journal Audit Socket. hub # [ 14.340046] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 14.342486] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 14.345076] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 14.347486] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 14.361011] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 14.362704] systemd[1]: Listening on udev Control Socket. hub # [ 14.364490] systemd[1]: Listening on udev Varlink Socket. hub # [ 14.370724] systemd[1]: Mounting Huge Pages File System... hub # [ 14.375203] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 14.384826] systemd[1]: Mounting Kernel Debug File System... hub # [ 14.392261] systemd[1]: Mounting Kernel Trace File System... hub # [ 14.403451] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 14.408408] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 14.421499] systemd[1]: Starting Load Kernel Module configfs... hub # [ 14.422937] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 14.426041] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 14.428480] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 14.468487] systemd[1]: Mounting FUSE Control File System... hub # [ 14.475055] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 14.501781] systemd[1]: Starting Journal Service... hub # [ 14.512886] systemd[1]: Starting Load Kernel Modules... hub # [ 14.549556] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 14.561225] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 14.572484] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 14.599386] systemd[1]: Starting Coldplug All udev Devices... hub # [ 14.640731] systemd[1]: Listening on Journal Log Access Socket. hub # [ 14.650235] systemd[1]: Mounted Huge Pages File System. hub # [ 14.657045] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 14.665446] systemd[1]: Mounted Kernel Debug File System. hub # [ 14.671976] systemd[1]: Mounted Kernel Trace File System. hub # [ 14.674775] systemd-journald[295]: Collecting audit messages is enabled. hub # [ 14.686128] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 14.703464] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 14.711971] systemd[1]: Finished Load Kernel Module configfs. hub # [ 14.720777] EXT4-fs (vda): re-mounted 15f00a32-7fbb-4a20-ba42-93fe607e9777. hub # [ 14.726256] systemd[1]: Mounted FUSE Control File System. hub # [ 14.732729] loop: module loaded hub # [ 14.743032] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 14.753108] systemd[1]: Finished Load Kernel Modules. hub # [ 14.765774] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 14.778846] systemd[1]: Mounting Kernel Configuration File System... hub # [ 14.795296] systemd[1]: Starting Firewall... hub # [ 14.803598] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 14.467823] systemd-oomd[297]: No swap; memory pressure usage will be degraded hub # [ 14.837804] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 14.866529] systemd[1]: Starting Apply Kernel Variables... hub # [ 14.911958] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 14.931068] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 14.961332] systemd[1]: Started Journal Service. hub # [ 15.082381] systemd-journald[295]: Received client request to flush runtime journal. hub # [ 16.015569] (udev-worker)[433]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 16.721591] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console hub # [ 16.827395] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 16.835701] ACPI: button: Power Button [PWRF] hub # [ 16.840934] mousedev: PS/2 mouse device common for all mice hub # [ 16.866744] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 hub # [ 16.884063] Console: switching to colour dummy device 80x25 hub # [ 17.019275] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 17.019279] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 17.030944] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic hub # [ 17.031988] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 hub # [ 17.042890] rtc_cmos 00:04: RTC can wake from S4 hub # [ 17.095123] rtc_cmos 00:04: registered as rtc0 hub # [ 17.100669] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized hub # [ 17.114117] rtc_cmos 00:04: setting system clock to 2026-08-30T17:26:33 UTC (1788110793) hub # [ 17.117996] parport_pc 00:02: reported by Plug and Play ACPI hub # [ 17.137044] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 17.148249] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 17.208296] systemd-ssh-issue[595]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. hub # [ 17.587131] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 17.587480] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 17.599479] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt hub # [ 17.599637] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD hub # [ 17.647398] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # [ 17.686285] ppdev: user-space parallel port driver hub # [ 17.690090] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) hub # [ 17.773105] Console: switching to colour frame buffer device 160x50 hub # [ 17.837835] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device hub # connecting to host... hub # [ 18.320297] kvm_amd: TSC scaling supported hub # [ 18.323644] kvm_amd: Nested Virtualization enabled hub # [ 18.324517] kvm_amd: Nested Paging enabled hub # [ 18.328509] kvm_amd: LBR virtualization supported hub # [ 18.335547] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 18.337918] kvm_amd: Virtual GIF supported hub # [ 18.792631] EDAC MC: Ver: 3.0.0 hub # [ 19.375379] 8021q: 802.1Q VLAN Support v1.8 hub # [ 19.379261] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 19.041771] systemd-vconsole-setup[680]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 19.590254] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 19.764801] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 19.767834] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 19.791982] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 19.793506] cfg80211: failed to load regulatory.db hub # [ 20.310557] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 22.574032] NET: Registered PF_PACKET protocol family worker # Disk image does not exist, creating the virtualisation disk image... worker: QEMU running (pid 54) worker # Formatting '/build/vm-state-worker/tmp.I0vuJeMHVa', 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: 9835a309-771f-400a-8cb2-cc3e20f1581a 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. (finished: start all VMs, in 454.26 seconds) hub: waiting for unit multi-user.target hub: waiting for the VM to finish booting hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 0.00 seconds) hub: (finished: waiting for the VM to finish booting, in 0.00 seconds) 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 hub: (finished: waiting for unit multi-user.target, in 0.23 seconds) worker: waiting for unit multi-user.target worker: waiting for the VM to finish booting 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[ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 9 18:25:30 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/26hda52lm7jw56v1vh6c00nqpyqw0ab7-nixos-system-worker-test/init regInfo=/nix/store/z1nkd7yjscbaadhh9yg8bjgs0z75vhh2-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 673812786 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.000918] last_pfn = 0x180000 max_arch_pfn = 0x400000000 worker # [ 0.000948] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000952] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.001003] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.003284] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.003309] Using GB pages for direct mapping worker # [ 0.003439] RAMDISK: [mem 0x7e33b000-0x7ffcffff] worker # [ 0.003448] ACPI: Early table checksum verification disabled worker # [ 0.003454] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) worker # [ 0.003460] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003467] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003476] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003480] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.003482] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003484] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003486] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003488] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003490] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] worker # [ 0.003492] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] worker # [ 0.003493] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.003493] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] worker # [ 0.003494] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] worker # [ 0.003495] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] worker # [ 0.003496] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] worker # [ 0.003999] No NUMA configuration found worker # [ 0.004000] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] worker # [ 0.004004] NODE_DATA(0) allocated [mem 0x17fff8780-0x17fffdcff] worker # [ 0.004133] Zone ranges: worker # [ 0.004135] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.004137] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] worker # [ 0.004138] Normal [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.004140] Device empty worker # [ 0.004141] Movable zone start for each node worker # [ 0.004142] Early memory node ranges worker # [ 0.004142] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.004143] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.004144] node 0: [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.004146] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] worker # [ 0.004170] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.004538] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.122230] On node 0, zone Normal: 43 pages in unavailable ranges worker # [ 0.123319] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.123334] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.123367] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.123370] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.123372] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.123373] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.123375] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.123375] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.123378] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.123379] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.123386] TSC deadline timer available worker # [ 0.123393] CPU topo: Max. logical packages: 1 worker # [ 0.123393] CPU topo: Max. logical dies: 1 worker # [ 0.123394] CPU topo: Max. dies per package: 1 worker # [ 0.123398] CPU topo: Max. threads per core: 1 worker # [ 0.123398] CPU topo: Num. cores per package: 1 worker # [ 0.123399] CPU topo: Num. threads per package: 1 worker # [ 0.123399] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.123421] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.123448] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.123449] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.123451] PM: hibernation: Registered nosave memory: [mem 0x7ffd5000-0xffffffff] worker # [ 0.123452] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.123454] Booting paravirtualized kernel on KVM worker # [ 0.123458] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.128437] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.131576] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.131659] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.131677] 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/26hda52lm7jw56v1vh6c00nqpyqw0ab7-nixos-system-worker-test/init regInfo=/nix/store/z1nkd7yjscbaadhh9yg8bjgs0z75vhh2-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.132044] Unknown kernel command line parameters "regInfo=/nix/store/z1nkd7yjscbaadhh9yg8bjgs0z75vhh2-closure-info/registration", will be passed to user space. worker # [ 0.132071] random: crng init done worker # [ 0.132072] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.137635] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) worker # [ 0.140393] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.140466] software IO TLB: area num 1. worker # [ 0.229801] Fallback order for Node 0: 0 worker # [ 0.229813] Built 1 zonelists, mobility grouping on. Total pages: 1048435 worker # [ 0.229815] Policy zone: Normal worker # [ 0.233386] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.248047] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.261580] allocated 8388608 bytes of page_ext worker # [ 0.272579] ftrace: allocating 48717 entries in 192 pages worker # [ 0.272586] ftrace: allocated 192 pages with 2 groups worker # [ 0.273751] Dynamic Preempt: lazy worker # [ 0.273965] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.273966] rcu: RCU event tracing is enabled. worker # [ 0.273966] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.273968] Trampoline variant of Tasks RCU enabled. worker # [ 0.273968] Rude variant of Tasks RCU enabled. worker # [ 0.273969] Tracing variant of Tasks RCU enabled. worker # [ 0.273969] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.273970] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.273990] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.273992] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.273994] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.280303] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.280637] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.280646] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.280789] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.287663] Console: colour VGA+ 80x25 worker # [ 0.287667] printk: legacy console [tty0] enabled worker # [ 0.333353] printk: legacy console [ttyS0] enabled worker # [ 0.518740] ACPI: Core revision 20250807 worker # [ 0.520053] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.522609] APIC: Switch to symmetric I/O mode setup worker # [ 0.524162] x2apic enabled worker # [ 0.525488] APIC: Switched APIC routing to: physical x2apic worker # [ 0.528442] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.530203] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.533043] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) worker # [ 0.534163] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.537401] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.538041] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.540053] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.542047] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.544041] Spectre V2 : Mitigation: Retpolines worker # [ 0.545041] RETBleed: Mitigation: untrained return thunk worker # [ 0.547042] Speculative Return Stack Overflow: Mitigation: SMT disabled worker # [ 0.548051] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.549044] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT worker # [ 0.551041] Spectre V2 : Enabling Speculation Barrier for firmware calls worker # [ 0.553051] active return thunk: retbleed_return_thunk worker # [ 0.554051] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.556059] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.557052] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.559124] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.561041] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.562040] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. worker # [ 0.594078] Freeing SMP alternatives memory: 44K worker # [ 0.595044] pid_max: default: 32768 minimum: 301 worker # [ 0.596182] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.598198] landlock: Up and running. worker # [ 0.599846] Yama: becoming mindful. worker # [ 0.601251] LSM support for eBPF active worker # [ 0.602224] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.603149] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.607202] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) worker # [ 0.608754] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.610050] ... version: 0 worker # [ 0.611041] ... bit width: 48 worker # [ 0.612054] ... generic counters: 6 worker # [ 0.613050] ... generic bitmap: 000000000000003f worker # [ 0.614043] ... fixed-purpose counters: 0 worker # [ 0.615042] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.616051] ... value mask: 0000ffffffffffff worker # [ 0.617044] ... max period: 00007fffffffffff worker # [ 0.618042] ... global_ctrl mask: 000000000000003f worker # [ 0.619183] signal: max sigframe size: 1776 worker # [ 0.620281] rcu: Hierarchical SRCU implementation. worker # [ 0.621050] rcu: Max phase no-delay instances is 400. worker # [ 0.625947] smp: Bringing up secondary CPUs ... worker # [ 0.627036] smp: Brought up 1 node, 1 CPU worker # [ 0.628042] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) worker # [ 0.629260] Memory: 3961432K/4193740K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 217848K reserved, 0K cma-reserved) worker # [ 0.630576] devtmpfs: initialized worker # [ 0.631264] x86/mm: Memory block size: 128MB worker # [ 0.633243] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.634079] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.635171] pinctrl core: initialized pinctrl subsystem worker # [ 0.636468] PM: RTC time: 17:33:12, date: 2026-08-30 worker # [ 0.640252] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.641936] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.643138] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.645120] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.646105] audit: initializing netlink subsys (disabled) worker # [ 0.647661] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.647665] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.648050] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.649063] audit: type=2000 audit(1788111192.178:1): state=initialized audit_enabled=0 res=1 worker # [ 0.651051] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.651053] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.652158] cpuidle: using governor menu worker # [ 0.655260] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.656399] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.657061] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.658071] PCI: Using configuration type 1 for base access worker # [ 0.659342] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.664366] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.665041] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.666043] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.673043] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.680434] ACPI: Added _OSI(Module Device) worker # [ 0.681042] ACPI: Added _OSI(Processor Device) worker # [ 0.686041] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.692751] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.697140] ACPI: Interpreter enabled worker # [ 0.698063] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.701042] ACPI: Using IOAPIC for interrupt routing worker # [ 0.702131] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.705042] PCI: Using E820 reservations for host bridge windows worker # [ 0.706208] ACPI: Enabled 2 GPEs in block 00 to 3F worker # [ 0.714835] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.716048] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.717122] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.718158] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.719600] PCI host bridge to bus 0000:00 worker # [ 0.720048] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.721056] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.722045] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.723044] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.724058] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.725044] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.726046] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.727286] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.728858] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.732136] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.733067] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.734091] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.735308] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.737199] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.740073] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.741058] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.742097] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] worker # [ 0.743061] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.745280] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.748075] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.749059] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.750097] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] worker # [ 0.752628] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.756070] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.757079] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.758143] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] worker # [ 0.760257] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.763056] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.764057] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.765090] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] worker # [ 0.767408] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.770069] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.771058] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.772119] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] worker # [ 0.774194] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.777067] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.778059] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.779090] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] worker # [ 0.781384] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.784015] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.785054] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.786160] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] worker # [ 0.787057] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.789371] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.791743] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.793096] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] worker # [ 0.795421] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.798075] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.799072] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.800099] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] worker # [ 0.802332] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.806075] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f] worker # [ 0.807057] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.808112] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] worker # [ 0.810270] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.813069] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.814100] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] worker # [ 0.816276] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.818629] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f] worker # [ 0.819711] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.822112] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f] worker # [ 0.823525] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.826131] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f] worker # [ 0.827629] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint worker # [ 0.830059] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] worker # [ 0.831527] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.832631] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 0.834499] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint worker # [ 0.836690] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf] worker # [ 0.837059] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] worker # [ 0.838705] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.841098] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] worker # [ 0.848041] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.849162] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.850173] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.851173] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.852167] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.853173] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 0.854166] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.855157] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.856100] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.857061] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.858056] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.859060] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 0.860055] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.861057] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.862066] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.863060] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 0.865193] iommu: Default domain type: Translated worker # [ 0.866050] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.867302] ACPI: bus type USB registered worker # [ 0.868103] usbcore: registered new interface driver usbfs worker # [ 0.869081] usbcore: registered new interface driver hub worker # [ 0.870055] usbcore: registered new device driver usb worker # [ 0.871862] NetLabel: Initializing worker # [ 0.872741] NetLabel: domain hash size = 128 worker # [ 0.873041] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.874134] NetLabel: unlabeled traffic allowed by default worker # [ 0.875055] PCI: Using ACPI for IRQ routing worker # [ 0.969162] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.970037] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.970037] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.970048] vgaarb: loaded worker # [ 0.971055] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.972042] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.980178] clocksource: Switched to clocksource kvm-clock worker # [ 0.984564] VFS: Disk quotas dquot_6.6.0 worker # [ 0.985886] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.988217] pnp: PnP ACPI init worker # [ 0.989744] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 0.991528] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 0.993955] pnp: PnP ACPI: found 6 devices worker # [ 1.001931] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 1.004112] clocksource: Switched to clocksource acpi_pm worker # [ 1.005713] NET: Registered PF_INET protocol family worker # [ 1.007851] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) worker # [ 1.026831] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) worker # [ 1.029306] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 1.031529] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 1.035061] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) worker # [ 1.037216] TCP: Hash tables configured (established 32768 bind 32768) worker # [ 1.039021] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) worker # [ 1.041135] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 1.043008] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 1.045210] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 1.046976] NET: Registered PF_XDP protocol family worker # [ 1.048384] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 1.050133] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 1.051730] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 1.053509] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] worker # [ 1.055301] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 1.057124] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] worker # [ 1.059869] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 1.062763] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 1.065498] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 1.067965] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 1.070455] PCI: CLS 0 bytes, default 64 worker # [ 1.071713] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) worker # [ 1.073654] Trying to unpack rootfs image as initramfs... worker # [ 1.081442] software IO TLB: mapped [mem 0x000000007a33b000-0x000000007e33b000] (64MB) worker # [ 1.084096] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 1.125752] Initialise system trusted keyrings worker # [ 1.130528] workingset: timestamp_bits=40 max_order=20 bucket_order=0 worker # [ 1.153344] Key type asymmetric registered worker # [ 1.156448] Asymmetric key parser 'x509' registered worker # [ 1.157865] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 1.165601] io scheduler mq-deadline registered worker # [ 1.166915] io scheduler kyber registered worker # [ 1.171162] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 1.173316] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 1.183865] Linux agpgart interface v0.103 worker # [ 1.185170] ACPI: bus type drm_connector registered worker # [ 1.188982] usbcore: registered new interface driver usbserial_generic worker # [ 1.190770] usbserial: USB Serial support registered for generic worker # [ 1.195450] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 1.197719] drop_monitor: Initializing network drop monitor service worker # [ 1.203621] NET: Registered PF_INET6 protocol family worker # [ 1.207835] Segment Routing with IPv6 worker # [ 1.211499] In-situ OAM (IOAM) with IPv6 worker # [ 1.213174] IPI shorthand broadcast: enabled worker # [ 1.219742] sched_clock: Marking stable (971024490, 248392211)->(1389648358, -170231657) worker # [ 1.227742] registered taskstats version 1 worker # [ 1.229116] Loading compiled-in X.509 certificates worker # [ 1.246436] Demotion targets for Node 0: null worker # [ 1.247843] Key type .fscrypt registered worker # [ 1.251445] Key type fscrypt-provisioning registered worker # [ 1.252836] ima: No TPM chip found, activating TPM-bypass! worker # [ 1.257449] ima: Allocated hash algorithm: sha1 worker # [ 1.258727] ima: No architecture policies found worker # [ 1.261681] PM: Magic number: 6:102:594 worker # [ 1.265946] RAS: Correctable Errors collector initialized. worker # [ 1.278059] clk: Disabling unused clocks worker # [ 1.280443] PM: genpd: Disabling unused power domains worker # [ 1.539960] Freeing initrd memory: 29268K worker # [ 1.544639] Freeing unused decrypted memory: 2028K worker # [ 1.547713] Freeing unused kernel image (initmem) memory: 3644K worker # [ 1.549306] Write protecting the kernel read-only data: 32768k worker # [ 1.551776] Freeing unused kernel image (text/rodata gap) memory: 1220K worker # [ 1.554099] Freeing unused kernel image (rodata/data gap) memory: 756K worker # [ 1.591078] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.592908] Run /init as init process worker # [ 1.605496] systemd[1]: Inserted module 'autofs4' worker # [ 1.625698] fuse: init (API version 7.45) worker # [ 1.632564] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.636199] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.641324] ACPI: \_SB_.GSIE: Enabled at IRQ 20 worker # [ 1.645091] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.681440] systemd[1]: Successfully made /usr/ read-only. worker # [ 2.018685] systemd[1]: systemd 261.1 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.026477] systemd[1]: Detected virtualization kvm. worker # [ 2.027908] systemd[1]: Detected architecture x86-64. worker # [ 2.029325] systemd[1]: Running in initrd. worker # [ 2.031144] systemd[1]: Initializing machine ID from random generator. worker # [ 2.033167] systemd[1]: Hostname set to . worker # [ 2.210653] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.256659] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 2.260776] systemd[1]: Created slice Slice /system/modprobe. worker # [ 2.262511] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 2.269190] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 2.270991] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 2.272711] systemd[1]: Reached target Path Units. worker # [ 2.274102] systemd[1]: Reached target Slice Units. worker # [ 2.275608] systemd[1]: Reached target Swaps. worker # [ 2.276851] systemd[1]: Reached target Timer Units. worker # [ 2.278440] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 2.280307] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 2.282239] systemd[1]: Listening on Journal Sockets. worker # [ 2.283835] systemd[1]: Listening on udev Control Socket. worker # [ 2.285688] systemd[1]: Listening on udev Kernel Socket. worker # [ 2.287092] systemd[1]: Reached target Socket Units. worker # [ 2.289495] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 2.296076] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 2.304769] systemd[1]: Starting Load Kernel Module configfs... worker # [ 2.317665] systemd[1]: Starting Journal Service... worker # [ 2.330669] systemd[1]: Starting Load Kernel Modules... worker # [ 2.337589] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.346541] netfs: FS-Cache loaded worker # [ 2.356138] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.367619] 9pnet: Installing 9P2000 support worker # [ 2.383565] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.390689] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 2.394728] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.404035] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.413031] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.418432] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.424132] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.431248] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.434335] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.450674] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 2.474861] systemd[1]: Finished Load Kernel Modules. worker # [ 2.485581] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.504533] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.515788] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.532984] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.553490] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.559781] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.565536] systemd[1]: Reached target Local File Systems. worker # [ 2.573488] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.336059] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 2.339437] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 2.589260] systemd[1]: Started Journal Service. worker # [ 2.342485] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.361368] systemd[1]: Starting Create System Files and Directories... worker # [ 2.396293] systemd[1]: Finished Create System Files and Directories. worker # [ 2.404272] systemd-udevd[76]: Using default interface naming scheme 'v261'. worker # [ 2.412049] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.428130] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.429780] systemd[1]: Reached target System Initialization. worker # [ 2.431058] systemd[1]: Reached target Basic System. worker # [ 2.923475] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.956927] virtio_blk virtio4: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) worker # [ 2.972063] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 2.973198] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 worker # [ 2.975948] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 worker # [ 2.985447] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 2.988431] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 2.990106] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.995776] usb usb1: Product: EHCI Host Controller worker # [ 2.997034] usb usb1: Manufacturer: Linux 6.18.44 ehci_hcd worker # [ 2.999429] usb usb1: SerialNumber: 0000:00:1d.7 worker # [ 3.003601] hub 1-0:1.0: USB hub found worker # [ 3.005698] hub 1-0:1.0: 6 ports detected worker # [ 3.021830] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 3.027863] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 3.028965] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 worker # [ 3.032757] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 3.045359] virtio_blk virtio5: [vdb] 2573280 512-byte logical blocks (1.32 GB/1.23 GiB) worker # [ 3.054624] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 3.057914] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 3.066869] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c240 worker # [ 3.077423] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 3.082588] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.084206] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.088286] SCSI subsystem initialized worker # [ 3.106893] usb usb2: Product: UHCI Host Controller worker # [ 3.121426] usb usb2: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 2.885905] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.137072] usb usb2: SerialNumber: 0000:00:1d.0 worker # [ 2.894480] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.897994] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.149686] hub 2-0:1.0: USB hub found worker # [ 3.159186] hub 2-0:1.0: 2 ports detected worker # [ 3.174787] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 3.178301] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 2.933868] systemd[1]: Starting Virtual Console Setup... worker # [ 3.216514] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 2.971343] systemd-vconsole-setup[110]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.976072] systemd[1]: Finished Virtual Console Setup. worker # [ 3.233213] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 3.234348] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c260 worker # [ 2.997522] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 3.249430] usb 1-1: new high-speed USB device number 2 using ehci-pci worker # [ 3.251097] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.006064] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 3.255712] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.010165] systemd[1]: Reached target Initrd Root Device. worker # [ 3.012272] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 3.264423] usb usb3: Product: UHCI Host Controller worker # [ 3.267661] usb usb3: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 3.270404] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 3.276777] hub 3-0:1.0: USB hub found worker # [ 3.284498] hub 3-0:1.0: 2 ports detected worker # [ 3.046201] systemd-fsck[116]: nixos: clean, 12/262144 files, 37198/1048576 blocks worker # [ 3.297466] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 3.298524] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 3.303228] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 3.304841] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 3.306629] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c280 worker # [ 3.308219] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 3.309976] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.311917] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 3.313656] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.317125] usb usb4: Product: UHCI Host Controller worker # [ 3.318702] scsi host0: ahci worker # [ 3.320490] usb usb4: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 3.322346] scsi host1: ahci worker # [ 3.324405] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 3.325597] scsi host2: ahci worker # [ 3.329273] scsi host3: ahci worker # [ 3.330544] hub 4-0:1.0: USB hub found worker # [ 3.333332] scsi host4: ahci worker # [ 3.334706] scsi host5: ahci worker # [ 3.335788] hub 4-0:1.0: 2 ports detected worker # [ 3.338182] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 44 lpm-pol 1 worker # [ 3.345429] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 44 lpm-pol 1 worker # [ 3.354559] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 44 lpm-pol 1 worker # [ 3.361450] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 44 lpm-pol 1 worker # [ 3.365452] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 44 lpm-pol 1 worker # [ 3.367168] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 44 lpm-pol 1 worker # [ 3.381479] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.383095] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.385215] usb 1-1: Product: QEMU USB Tablet worker # [ 3.386740] usb 1-1: Manufacturer: QEMU worker # [ 3.387912] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 3.402571] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.680621] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 3.682037] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.683542] ata3.00: applying bridge limits worker # [ 3.684711] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 3.686181] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 3.687639] ata2: SATA link down (SStatus 0 SControl 300) worker # [ 3.689001] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 3.690412] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 3.691678] ata3.00: configured for UDMA/100 worker # [ 3.693064] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.722165] usbcore: registered new interface driver usbhid worker # [ 3.725814] usbhid: USB HID core driver worker # [ 3.733326] 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 worker # [ 3.735886] 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.738817] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.750422] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 6.544563] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 6.553126] systemd[1]: Mounting /sysroot... worker: Guest root shell did not produce any data yet... worker: To debug, enter the VM and run 'systemctl status backdoor.service'. worker # [ 40.136951] EXT4-fs (vda): mounted filesystem 9835a309-771f-400a-8cb2-cc3e20f1581a r/w with ordered data mode. Quota mode: none. worker # [ 40.045205] systemd[1]: Mounted /sysroot. worker # [ 40.065154] systemd[1]: Reached target Initrd Root File System. worker # [ 40.152685] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 40.160409] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 40.169171] systemd[1]: Mounting /sysroot/run... worker # [ 40.181142] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 40.197949] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 40.217158] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 40.289847] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 40.543229] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 40.426245] systemd-sysroot-fstab-check[160]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 40.677182] 9p: Installing v9fs 9p2000 file system support worker # [ 40.438119] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 40.442592] systemd[1]: Mounted /sysroot/run. worker # [ 40.444431] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 40.446480] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 40.455137] systemd[1]: Reload requested from client PID 160 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 40.458288] systemd[1]: Reloading... worker # [ 40.590992] systemd[1]: Reloading finished in 131 ms. worker # [ 40.600765] systemd-sysroot-fstab-check[160]: Requesting initrd-fs.target/start/replace... worker # [ 40.607269] systemd-sysroot-fstab-check[160]: Requesting swap.target/start/replace... worker # [ 40.611299] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 40.617806] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 40.620137] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 40.622045] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 40.643843] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 40.647089] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 40.930547] systemd[1]: Mounting /sysroot/nix/store... worker # [ 40.971138] systemd[1]: Mounted /sysroot/nix/store. worker # [ 40.974858] systemd[1]: Reached target Initrd File Systems. worker # [ 40.989132] systemd[1]: Starting Find NixOS closure... worker # [ 40.997919] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 41.040369] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 41.044125] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 41.058247] systemd[1]: Finished Find NixOS closure. worker # [ 41.063140] systemd[1]: Reached target Initrd Default Target. worker # [ 41.064985] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 41.094174] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 41.097225] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 41.101445] systemd[1]: Stopped target Initrd Default Target. worker # [ 41.104346] systemd[1]: Stopped target Basic System. worker # [ 41.107390] systemd[1]: Stopped target Initrd Root Device. worker # [ 41.110657] systemd[1]: Stopped target Path Units. worker # [ 41.112717] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 41.115398] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 41.118424] systemd[1]: Stopped target Slice Units. worker # [ 41.121130] systemd[1]: Stopped target Socket Units. worker # [ 41.122482] systemd[1]: Stopped target System Initialization. worker # [ 41.123869] systemd[1]: Stopped target Swaps. worker # [ 41.125769] systemd[1]: Stopped target Timer Units. worker # [ 41.126928] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 41.129308] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 41.130917] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 41.135972] systemd[1]: Stopped Find NixOS closure. worker # [ 41.137466] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 41.140295] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 41.142289] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 41.144222] systemd[1]: Stopped Apply Kernel Variables. worker # [ 41.146242] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 41.148170] systemd[1]: Stopped Load Kernel Modules. worker # [ 41.150312] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 41.152318] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 41.156304] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 41.158113] systemd[1]: Stopped Create System Files and Directories. worker # [ 41.161315] systemd[1]: Stopped target Local File Systems. worker # [ 41.162768] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 41.166357] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 41.168894] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 41.173428] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 41.176205] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 41.178201] systemd[1]: Stopped Virtual Console Setup. worker # [ 41.184137] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 41.187990] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 41.196170] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 41.199288] systemd[1]: Closed udev Control Socket. worker # [ 41.204363] systemd[1]: Starting Cleanup udev Database... worker # [ 41.208288] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 41.210481] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 41.211993] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 41.213853] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 41.216373] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 41.218795] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 41.227139] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 41.231210] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 41.256960] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 41.259834] systemd[1]: Finished Cleanup udev Database. worker # [ 41.262209] systemd[1]: Reached target Switch Root. worker # [ 41.264609] systemd[1]: Starting NixOS Activation... worker # [ 41.520192] initrd-nixos-activation-start[209]: booting system configuration /nix/store/26hda52lm7jw56v1vh6c00nqpyqw0ab7-nixos-system-worker-test worker # [ 41.554207] initrd-nixos-activation-start[209]: running activation script... worker # [ 42.018731] initrd-nixos-activation-start[232]: setting up /etc... worker # [ 42.197240] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 42.204437] systemd[1]: Finished NixOS Activation. worker # [ 42.208400] systemd[1]: Starting Switch Root... worker # [ 42.235706] systemd[1]: Switching root. worker # [ 42.636888] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker: Guest root shell did not produce any data yet... worker: To debug, enter the VM and run 'systemctl status backdoor.service'. worker # [ 65.115778] NET: Registered PF_VSOCK protocol family worker # [ 65.499701] systemd[1]: systemd 261.1 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 # [ 65.511463] systemd[1]: Detected virtualization kvm. worker # [ 65.512593] systemd[1]: Detected architecture x86-64. worker # [ 65.513921] systemd[1]: Detected first boot. worker # [ 65.515442] systemd[1]: Initializing machine ID from random generator. worker # [ 65.837759] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 66.093119] systemd[1]: Applying preset policy. worker # [ 66.413455] systemd[1]: Populated /etc with preset unit settings. worker # [ 67.153217] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 67.157511] systemd[1]: Stopped initrd-switch-root.service. worker # [ 67.168585] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 67.183850] systemd[1]: Created slice Slice /system/getty. worker # [ 67.189306] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 67.193380] systemd[1]: Created slice User and Session Slice. worker # [ 67.196098] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 67.198338] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 67.201754] systemd[1]: Expecting device /dev/hvc0... worker # [ 67.203384] systemd[1]: Expecting device /dev/ttyS0... worker # [ 67.205623] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 67.208902] systemd[1]: Stopped target initrd-fs.target. worker # [ 67.210138] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 67.212826] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 67.214652] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 67.217370] systemd[1]: Reached target Path Units. worker # [ 67.219890] systemd[1]: Reached target Remote File Systems. worker # [ 67.222328] systemd[1]: Reached target Slice Units. worker # [ 67.224542] systemd[1]: Reached target Swaps. worker # [ 67.227871] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 67.233194] systemd[1]: Listening on Process Core Dump Socket. worker # [ 67.237098] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 67.241576] systemd[1]: Listening on Factory Reset Management. worker # [ 67.247156] systemd[1]: Listening on Hostname Service Socket. worker # [ 67.252678] systemd[1]: Starting Journal Log Access Socket... worker # [ 67.256136] systemd[1]: Listening on Journal Audit Socket. worker # [ 67.259392] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 67.261622] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 67.264553] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 67.266850] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 67.278239] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 67.282376] systemd[1]: Listening on udev Control Socket. worker # [ 67.284118] systemd[1]: Listening on udev Varlink Socket. worker # [ 67.290192] systemd[1]: Mounting Huge Pages File System... worker # [ 67.296894] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 67.312909] systemd[1]: Mounting Kernel Debug File System... worker # [ 67.330008] systemd[1]: Mounting Kernel Trace File System... worker # [ 67.391179] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 67.399070] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 67.420132] systemd[1]: Starting Load Kernel Module configfs... worker # [ 67.423896] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 67.428339] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 67.436945] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 67.447899] systemd[1]: Mounting FUSE Control File System... worker # [ 67.453087] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 67.471863] systemd[1]: Starting Journal Service... worker # [ 67.484858] systemd[1]: Starting Load Kernel Modules... worker # [ 67.500948] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 67.555933] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 67.563370] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 67.642509] systemd[1]: Starting Coldplug All udev Devices... worker # [ 67.673450] systemd[1]: Listening on Journal Log Access Socket. worker # [ 67.676039] systemd[1]: Mounted Huge Pages File System. worker # [ 67.678171] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 67.683289] systemd[1]: Mounted Kernel Debug File System. worker # [ 67.687348] systemd[1]: Mounted Kernel Trace File System. worker # [ 67.691398] systemd[1]: Mounted FUSE Control File System. worker # [ 67.726882] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 67.739175] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 67.783776] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 67.792272] systemd[1]: Finished Load Kernel Module configfs. worker # [ 67.826891] systemd[1]: Mounting Kernel Configuration File System... worker # [ 67.857071] systemd[1]: Mounted Kernel Configuration File System. worker # [ 67.899766] EXT4-fs (vda): re-mounted 9835a309-771f-400a-8cb2-cc3e20f1581a. worker # [ 67.919277] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 67.924469] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 67.928464] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 67.939121] systemd-journald[302]: Collecting audit messages is enabled. worker # [ 67.941839] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 67.943814] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 67.945792] loop: module loaded worker # [ 67.954106] systemd[1]: Finished Load Kernel Modules. worker # [ 67.963081] systemd[1]: Starting Firewall... worker # [ 67.970886] systemd[1]: Starting Apply Kernel Variables... worker # [ 68.070968] systemd[1]: Started Journal Service. worker # [ 67.961371] systemd-oomd[304]: No swap; memory pressure usage will be degraded worker # [ 68.221433] systemd-journald[302]: Received client request to flush runtime journal. worker # [ 69.441451] (udev-worker)[473]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 69.979316] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 70.001030] mousedev: PS/2 mouse device common for all mice worker # [ 70.022432] ACPI: button: Power Button [PWRF] worker # [ 70.037223] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 70.062234] rtc_cmos 00:04: RTC can wake from S4 worker # [ 70.085427] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 70.095094] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 worker # [ 70.096818] rtc_cmos 00:04: registered as rtc0 worker # [ 70.096937] rtc_cmos 00:04: setting system clock to 2026-08-30T17:34:22 UTC (1788111262) worker # [ 70.097080] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 70.105071] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 70.105203] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 70.109286] Console: switching to colour dummy device 80x25 worker # [ 70.167613] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 70.168592] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 70.177994] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 70.178611] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 70.197914] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 70.198937] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 70.231192] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 70.233060] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 70.373416] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 70.380565] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 70.386746] ppdev: user-space parallel port driver worker # [ 70.442911] Console: switching to colour frame buffer device 160x50 worker # [ 70.453719] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 70.300498] systemd-vconsole-setup[598]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 70.560313] kvm_amd: TSC scaling supported worker # [ 70.561107] kvm_amd: Nested Virtualization enabled worker # [ 70.562180] kvm_amd: Nested Paging enabled worker # [ 70.564002] kvm_amd: LBR virtualization supported worker # [ 70.565096] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 70.566133] kvm_amd: Virtual GIF supported worker # [ 70.592310] EDAC MC: Ver: 3.0.0 worker # [ 81.221466] systemd-ssh-issue[604]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # connecting to host... worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 82.60 seconds) worker: (finished: waiting for the VM to finish booting, in 82.60 seconds) worker # [ 83.268753] 8021q: 802.1Q VLAN Support v1.8 worker # [ 83.269487] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 83.481313] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 83.493317] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 83.496819] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 83.504850] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 83.506347] cfg80211: failed to load regulatory.db worker # [ 83.585836] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 85.397298] NET: Registered PF_PACKET protocol family worker: (finished: waiting for unit multi-user.target, in 92.75 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.49 seconds) hub: must succeed: tribuchet ca issue hub --dir /root/ca hub: (finished: must succeed: tribuchet ca issue hub --dir /root/ca, in 0.15 seconds) hub: must succeed: tribuchet ca issue worker --dir /root/ca hub: (finished: must succeed: tribuchet ca issue worker --dir /root/ca, in 5.46 seconds) hub: must succeed: mkdir -p /etc/tribuchet/ca hub: (finished: must succeed: mkdir -p /etc/tribuchet/ca, in 0.06 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.06 seconds) worker: must succeed: mkdir -p /var/lib/tribuchet/tls worker: (finished: must succeed: mkdir -p /var/lib/tribuchet/tls, in 0.02 seconds) hub: must succeed: cat /root/ca/worker.crt hub: (finished: must succeed: cat /root/ca/worker.crt, in 0.06 seconds) worker: must succeed: cat > /var/lib/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBWTCB/6ADAgECAhQZez60vJ8yP7vFJtEOzF5/xTxFbDAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDgzMDE3MzQ0 NFoXDTI4MDgyOTE3MzQ0NFowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABIHMfajhsPY0QhNpa/xmZUtH h9ARVhqZ7A/jQSUNsitnfEnB9P5O+MJBsB3BpXV3MR1CUsYSMlCuBmfYcuBaw1qj FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNJADBGAiEAqBPtNlmq kQVQCGCyjZiedxyo/nxbSz7u2l1p2vd3nmECIQDpF5qMwW7PXjrWNnc28zCvqatg cCd4MeEmkLmE2A26fA== -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /var/lib/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBWTCB/6ADAgECAhQZez60vJ8yP7vFJtEOzF5/xTxFbDAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDgzMDE3MzQ0 NFoXDTI4MDgyOTE3MzQ0NFowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABIHMfajhsPY0QhNpa/xmZUtH h9ARVhqZ7A/jQSUNsitnfEnB9P5O+MJBsB3BpXV3MR1CUsYSMlCuBmfYcuBaw1qj FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNJADBGAiEAqBPtNlmq kQVQCGCyjZiedxyo/nxbSz7u2l1p2vd3nmECIQDpF5qMwW7PXjrWNnc28zCvqatg cCd4MeEmkLmE2A26fA== -----END CERTIFICATE----- PEMEOF, in 0.01 seconds) hub: must succeed: cat /root/ca/worker.key hub: (finished: must succeed: cat /root/ca/worker.key, in 0.09 seconds) worker: must succeed: cat > /var/lib/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgMZWilbrauiHcT3Qy hhwBTA4DTvE9rA8gjiPqC1m1bfChRANCAASBzH2o4bD2NEITaWv8ZmVLR4fQEVYa mewP40ElDbIrZ3xJwfT+TvjCQbAdwaV1dzEdQlLGEjJQrgZn2HLgWsNa -----END PRIVATE KEY----- PEMEOF worker: (finished: must succeed: cat > /var/lib/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgMZWilbrauiHcT3Qy hhwBTA4DTvE9rA8gjiPqC1m1bfChRANCAASBzH2o4bD2NEITaWv8ZmVLR4fQEVYa mewP40ElDbIrZ3xJwfT+TvjCQbAdwaV1dzEdQlLGEjJQrgZn2HLgWsNa -----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.10 seconds) worker: must succeed: cat > /var/lib/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBjzCCATWgAwIBAgIUaXUhVsfLmfOpQQ86rbyinNu9wEowCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA4MzAxNzM0 NDRaFw0zNjA4MjcxNzM0NDRaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAS+1vld/QEV3Nsf1OsUZFk8 7QidpExpPckSd5tTBpdnox1VC//ZMXL96e7VPnhIGQboh0VDQi2B67FEqkHv2v06 o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFJUHgC/37ovE OGzeLqum8Rqj/blZMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIh APMs8W4T0Ix9FoPPZsge9PuJG3+xmRuR5e4KLYUBCfmqAiAktt0uoRuuMc24LghI xicPf9BMq96ehF3bIzXY6lN19Q== -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /var/lib/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBjzCCATWgAwIBAgIUaXUhVsfLmfOpQQ86rbyinNu9wEowCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA4MzAxNzM0 NDRaFw0zNjA4MjcxNzM0NDRaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAS+1vld/QEV3Nsf1OsUZFk8 7QidpExpPckSd5tTBpdnox1VC//ZMXL96e7VPnhIGQboh0VDQi2B67FEqkHv2v06 o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFJUHgC/37ovE OGzeLqum8Rqj/blZMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIh APMs8W4T0Ix9FoPPZsge9PuJG3+xmRuR5e4KLYUBCfmqAiAktt0uoRuuMc24LghI xicPf9BMq96ehF3bIzXY6lN19Q== -----END CERTIFICATE----- PEMEOF, in 0.01 seconds) worker: must succeed: chown -R tribuchet:tribuchet /var/lib/tribuchet/tls worker: (finished: must succeed: chown -R tribuchet:tribuchet /var/lib/tribuchet/tls, in 0.24 seconds) (finished: subtest: certificate authority, in 6.76 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.32 seconds) hub: must succeed: systemctl start tribuchet-hub hub: (finished: must succeed: systemctl start tribuchet-hub, in 0.27 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 99.679360] tribuchet[1021]: 2026-08-30T17:34:52.329638Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/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/1ylywfsgvg3d99q1qg5ar26zi51dbki2-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: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock"], spawn_agents: 0, agent_uid_base: None } worker # [ 99.698556] tribuchet[1021]: 2026-08-30T17:34:52.347191Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.43 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered' worker # [ 99.733171] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1025]: 2026-08-30T17:34:52.383391Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 99.740936] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1025]: 2026-08-30T17:34:52.391617Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 99.748498] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1025]: 2026-08-30T17:34:52.396751Z INFO tribuchet::worker::agent: agent listening uid=993 worker # [ 99.785537] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1029]: 2026-08-30T17:34:52.435971Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 99.790965] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1029]: 2026-08-30T17:34:52.441658Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 99.795446] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1029]: 2026-08-30T17:34:52.445632Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 99.974885] tribuchet[1021]: 2026-08-30T17:34:52.624684Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 516.287584] tribuchet[928]: 2026-08-30T17:34:51.374434Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 516.295236] tribuchet[928]: 2026-08-30T17:34:51.408642Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 516.308103] tribuchet[928]: 2026-08-30T17:34:52.113831Z 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: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered', in 1.60 seconds) (finished: subtest: worker registers at hub over mTLS, in 2.62 seconds) subtest: worker sshd reachable for the harness backdoor hub: waiting for unit sshd.service hub: (finished: waiting for unit sshd.service, in 0.23 seconds) worker: waiting for unit sshd.service worker: (finished: waiting for unit sshd.service, in 0.10 seconds) (finished: subtest: worker sshd reachable for the harness backdoor, in 0.34 seconds) subtest: daemon lifecycle running 1 test test lifecycle ... hub # [ 519.365654] systemd[959]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 520.824456] systemd[959]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 106.969700] systemd[1048]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 107.150731] systemd[1048]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 536.991216] tribuchet[928]: 2026-08-30T17:35:13.716648Z INFO tribuchet::hub::submit: queueing build id="929baef0d543641f9c0442fc56b84604" system="x86_64-linux" hub # [ 537.004206] tribuchet[928]: 2026-08-30T17:35:13.731422Z INFO tribuchet::hub: dispatching build id="929baef0d543641f9c0442fc56b84604" worker="worker" worker # [ 121.734139] tribuchet[1021]: 2026-08-30T17:35:14.248311Z INFO tribuchet::worker::session: build assigned id="929baef0d543641f9c0442fc56b84604" worker # [ 121.920148] nix-daemon[1072]: accepted connection from pid 1021, user tribuchet (trusted) hub # [ 537.398541] tribuchet[928]: 2026-08-30T17:35:14.125893Z INFO tribuchet::hub::relay::staging: input path negotiation done id="929baef0d543641f9c0442fc56b84604" total=8 missing=1 hub # [ 539.777841] nix-daemon[1025]: accepted connection from pid 928, user root (trusted) worker # [ 124.577752] nix-daemon[1072]: accepted connection from pid 1021, user tribuchet (trusted) worker # [ 124.950194] tribuchet[1021]: 2026-08-30T17:35:17.599081Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="929baef0d543641f9c0442fc56b84604" fixed_output=false network=false net_isolation=false worker # [ 125.010863] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1029]: 2026-08-30T17:35:17.654407Z INFO tribuchet::worker::agent: builder started id="929baef0d543641f9c0442fc56b84604" pid=1082 worker # [ 125.017423] tribuchet[1021]: 2026-08-30T17:35:17.658038Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="929baef0d543641f9c0442fc56b84604" pid=1082 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/6d6194a16820eb15/build worker # [ 125.327431] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1029]: 2026-08-30T17:35:17.977901Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 125.472248] tribuchet[1021]: 2026-08-30T17:35:18.122454Z INFO tribuchet::worker::build::agent_exec: builder finished id="929baef0d543641f9c0442fc56b84604" exit_code=0 aborted=None worker # [ 126.807182] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 1194332877 wd_nsec: 1194332505 worker # [ 126.914627] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1029]: 2026-08-30T17:35:19.564902Z INFO tribuchet::worker::agent: cleanup done id="929baef0d543641f9c0442fc56b84604" worker # [ 128.443875] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1093]: 2026-08-30T17:35:21.094228Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 128.464957] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1093]: 2026-08-30T17:35:21.115618Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 128.472647] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1093]: 2026-08-30T17:35:21.123127Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 128.480841] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1093]: 2026-08-30T17:35:21.131511Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 128.510853] tribuchet[1021]: 2026-08-30T17:35:21.159291Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="929baef0d543641f9c0442fc56b84604" worker # [ 128.901110] tribuchet[1021]: 2026-08-30T17:35:21.551694Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="929baef0d543641f9c0442fc56b84604" [e2e] heartbeat t=30s hub # [ 553.116708] tribuchet[928]: 2026-08-30T17:35:29.843753Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 138.020580] tribuchet[1021]: 2026-08-30T17:35:30.670414Z 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 # [ 138.773399] tribuchet[1021]: 2026-08-30T17:35:31.173196Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 554.795556] nix-daemon[1025]: reaped child process 1027, status = succeeded hub # [ 555.688576] tribuchet[1053]: 2026-08-30T17:35:32.415392Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 555.736619] tribuchet[1053]: 2026-08-30T17:35:32.463977Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 556.146289] tribuchet[1053]: 2026-08-30T17:35:32.872077Z 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 # [ 140.778082] tribuchet[1021]: 2026-08-30T17:35:33.428274Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 150.081921] systemd[1108]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 150.309336] systemd[1108]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 575.785514] tribuchet[1053]: 2026-08-30T17:35:52.512589Z INFO tribuchet::hub::submit: queueing build id="8ead993746e5fa354f90f45283fb4f89" system="x86_64-linux" hub # [ 575.912637] tribuchet[1053]: 2026-08-30T17:35:52.640023Z INFO tribuchet::hub: dispatching build id="8ead993746e5fa354f90f45283fb4f89" worker="worker" [e2e] heartbeat t=60s worker # [ 162.325010] hrtimer: interrupt took 445485949 ns worker # [ 162.141132] tribuchet[1021]: 2026-08-30T17:35:54.747113Z INFO tribuchet::worker::session: build assigned id="8ead993746e5fa354f90f45283fb4f89" worker # [ 162.648512] nix-daemon[1072]: accepted connection from pid 1021, user tribuchet (trusted) hub # [ 578.463089] tribuchet[1053]: 2026-08-30T17:35:55.189583Z INFO tribuchet::hub::relay::staging: input path negotiation done id="8ead993746e5fa354f90f45283fb4f89" total=7 missing=0 worker # [ 163.072841] tribuchet[1021]: 2026-08-30T17:35:55.709344Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="8ead993746e5fa354f90f45283fb4f89" fixed_output=false network=false net_isolation=false worker # [ 163.184155] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:35:55.833976Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 163.192461] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:35:55.842931Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 163.197876] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:35:55.843028Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 163.226569] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:35:55.875953Z INFO tribuchet::worker::agent: builder started id="8ead993746e5fa354f90f45283fb4f89" pid=1193 worker # [ 163.232528] tribuchet[1021]: 2026-08-30T17:35:55.876122Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="8ead993746e5fa354f90f45283fb4f89" pid=1193 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/b3f96c83c93d488c/build worker # [ 163.694772] tribuchet[1021]: 2026-08-30T17:35:56.343100Z INFO tribuchet::worker: handover requested; exiting hub # [ 579.169586] tribuchet[1053]: 2026-08-30T17:35:55.896915Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 579.176443] tribuchet[1053]: 2026-08-30T17:35:55.903641Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="8ead993746e5fa354f90f45283fb4f89" worker # [ 163.749305] systemd[1]: tribuchet-worker.service: Consumed 95ms CPU time over 1min 4.277s wall clock time, 19.5M memory peak, 17.6M read from disk, 8K written to disk, 9.2K incoming IP traffic, 6.4K outgoing IP traffic. worker # [ 163.937160] tribuchet[1205]: 2026-08-30T17:35:56.584217Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/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/1ylywfsgvg3d99q1qg5ar26zi51dbki2-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: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock"], spawn_agents: 0, agent_uid_base: None } worker # [ 163.962394] tribuchet[1205]: 2026-08-30T17:35:56.612376Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 164.041667] tribuchet[1205]: 2026-08-30T17:35:56.691991Z INFO tribuchet::worker::resume: adopted running build id="8ead993746e5fa354f90f45283fb4f89" pid=1193 worker # [ 164.062902] nix-daemon[1072]: accepted connection from pid 1205, user tribuchet (trusted) hub # [ 579.531293] tribuchet[1053]: 2026-08-30T17:35:56.257607Z 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 # [ 164.107571] tribuchet[1205]: 2026-08-30T17:35:56.758218Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 579.539408] tribuchet[1053]: 2026-08-30T17:35:56.257763Z INFO tribuchet::hub: dispatching build id="8ead993746e5fa354f90f45283fb4f89" worker="worker" worker # [ 164.112462] tribuchet[1205]: 2026-08-30T17:35:56.762986Z INFO tribuchet::worker::session: build resumed id="8ead993746e5fa354f90f45283fb4f89" key="295995c7ac3050f4a98ca48e4dc4dac9b26030c821871d30273e52a08a2f185a" hub # [ 579.546474] tribuchet[1053]: 2026-08-30T17:35:56.273651Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="8ead993746e5fa354f90f45283fb4f89" hub # [ 583.139696] hrtimer: interrupt took 7088611 ns hub # [ 585.157917] systemd[1116]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 587.196408] systemd[1116]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 588.853785] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 1122532776 wd_nsec: 1122531922 hub # [ 588.824348] tribuchet[1053]: 2026-08-30T17:36:05.549352Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance hub # [ 588.985253] tribuchet[1132]: 2026-08-30T17:36:05.710774Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 588.993271] tribuchet[1132]: 2026-08-30T17:36:05.710995Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock worker # [ 174.075879] tribuchet[1205]: 2026-08-30T17:36:06.149164Z 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 # [ 174.096317] tribuchet[1205]: 2026-08-30T17:36:06.149232Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 589.956996] tribuchet[1132]: 2026-08-30T17:36:06.684187Z 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 # [ 174.544066] tribuchet[1205]: 2026-08-30T17:36:07.194028Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 590.836063] tribuchet[1132]: 2026-08-30T17:36:07.561908Z INFO tribuchet::hub::submit: queueing build id="499cf92fea0d0b4ee59ef6dc2eea2aae" system="x86_64-linux" worker # [ 175.428644] tribuchet[1205]: 2026-08-30T17:36:08.079276Z INFO tribuchet::worker::session: build resumed id="499cf92fea0d0b4ee59ef6dc2eea2aae" key="295995c7ac3050f4a98ca48e4dc4dac9b26030c821871d30273e52a08a2f185a" hub # [ 590.865988] tribuchet[1132]: 2026-08-30T17:36:07.562351Z INFO tribuchet::hub: dispatching build id="499cf92fea0d0b4ee59ef6dc2eea2aae" worker="worker" hub # [ 590.900571] tribuchet[1132]: 2026-08-30T17:36:07.627331Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="499cf92fea0d0b4ee59ef6dc2eea2aae" worker # [ 182.908768] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:36:15.559056Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 182.924961] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:36:15.575490Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 182.977644] tribuchet[1205]: 2026-08-30T17:36:15.627755Z INFO tribuchet::worker::build::agent_exec: builder finished id="8ead993746e5fa354f90f45283fb4f89" exit_code=0 aborted=None worker # [ 183.000383] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1185]: 2026-08-30T17:36:15.651027Z INFO tribuchet::worker::agent: cleanup done id="8ead993746e5fa354f90f45283fb4f89" worker # [ 183.146323] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1229]: 2026-08-30T17:36:15.796598Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 183.174734] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1229]: 2026-08-30T17:36:15.825311Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 183.192786] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1229]: 2026-08-30T17:36:15.833972Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 183.213113] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1229]: 2026-08-30T17:36:15.834497Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 183.321766] tribuchet[1205]: 2026-08-30T17:36:15.944286Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="499cf92fea0d0b4ee59ef6dc2eea2aae" worker # [ 185.286141] tribuchet[1205]: 2026-08-30T17:36:17.936356Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="499cf92fea0d0b4ee59ef6dc2eea2aae" [e2e] heartbeat t=90s worker # [ 197.570330] systemd[1242]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 197.833564] systemd[1242]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 620.348475] tribuchet[1132]: 2026-08-30T17:36:37.075020Z INFO tribuchet::hub::submit: queueing build id="775d71fcfda87206696f85281931376d" system="x86_64-linux" hub # [ 620.355796] tribuchet[1132]: 2026-08-30T17:36:37.081955Z INFO tribuchet::hub: dispatching build id="775d71fcfda87206696f85281931376d" worker="worker" worker # [ 204.929510] tribuchet[1205]: 2026-08-30T17:36:37.577865Z INFO tribuchet::worker::session: build assigned id="775d71fcfda87206696f85281931376d" worker # [ 204.958848] nix-daemon[1072]: accepted connection from pid 1205, user tribuchet (trusted) hub # [ 620.411528] tribuchet[1132]: 2026-08-30T17:36:37.138839Z INFO tribuchet::hub::relay::staging: input path negotiation done id="775d71fcfda87206696f85281931376d" total=7 missing=0 worker # [ 204.977320] tribuchet[1205]: 2026-08-30T17:36:37.627997Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="775d71fcfda87206696f85281931376d" fixed_output=false network=false net_isolation=false worker # [ 205.082547] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1262]: 2026-08-30T17:36:37.732840Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 205.095509] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1262]: 2026-08-30T17:36:37.746184Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 205.108352] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1262]: 2026-08-30T17:36:37.756884Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 205.447068] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1262]: 2026-08-30T17:36:37.938945Z INFO tribuchet::worker::agent: builder started id="775d71fcfda87206696f85281931376d" pid=1269 worker # [ 205.502235] tribuchet[1205]: 2026-08-30T17:36:37.939164Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="775d71fcfda87206696f85281931376d" pid=1269 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/24b5ea083d1fa668/build [e2e] heartbeat t=120s worker # [ 232.868300] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1262]: 2026-08-30T17:37:05.482401Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 233.254093] tribuchet[1205]: 2026-08-30T17:37:05.750290Z INFO tribuchet::worker::build::agent_exec: builder finished id="775d71fcfda87206696f85281931376d" exit_code=0 aborted=None worker # [ 234.066622] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1262]: 2026-08-30T17:37:06.701066Z INFO tribuchet::worker::agent: cleanup done id="775d71fcfda87206696f85281931376d" worker # [ 234.191506] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1284]: 2026-08-30T17:37:06.841856Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 234.216352] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1284]: 2026-08-30T17:37:06.867026Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 234.221714] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1284]: 2026-08-30T17:37:06.872302Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 234.228753] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1284]: 2026-08-30T17:37:06.876652Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 234.325990] tribuchet[1205]: 2026-08-30T17:37:06.975285Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="775d71fcfda87206696f85281931376d" worker # [ 234.699772] tribuchet[1205]: 2026-08-30T17:37:07.350382Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="775d71fcfda87206696f85281931376d" worker # [ 236.085626] systemd[1297]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 236.220535] systemd[1297]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 240.883792] tribuchet[1205]: 2026-08-30T17:37:13.533919Z INFO tribuchet::worker::session: build assigned id="c8d0dd971af7525e94d2ab4a8fffbc2b" hub # [ 656.308422] tribuchet[1132]: 2026-08-30T17:37:13.035257Z INFO tribuchet::hub::submit: queueing build id="c8d0dd971af7525e94d2ab4a8fffbc2b" system="x86_64-linux" worker # [ 240.890463] nix-daemon[1072]: accepted connection from pid 1205, user tribuchet (trusted) hub # [ 656.316359] tribuchet[1132]: 2026-08-30T17:37:13.035347Z INFO tribuchet::hub: dispatching build id="c8d0dd971af7525e94d2ab4a8fffbc2b" worker="worker" worker # [ 240.898481] tribuchet[1205]: 2026-08-30T17:37:13.549148Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="c8d0dd971af7525e94d2ab4a8fffbc2b" fixed_output=false network=false net_isolation=false hub # [ 656.328130] tribuchet[1132]: 2026-08-30T17:37:13.055402Z INFO tribuchet::hub::relay::staging: input path negotiation done id="c8d0dd971af7525e94d2ab4a8fffbc2b" total=7 missing=0 worker # [ 240.936478] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:13.586886Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 240.942731] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:13.593309Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 240.957239] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:13.593369Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 240.995268] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:13.643883Z INFO tribuchet::worker::agent: builder started id="c8d0dd971af7525e94d2ab4a8fffbc2b" pid=1351 worker # [ 241.005946] tribuchet[1205]: 2026-08-30T17:37:13.643975Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="c8d0dd971af7525e94d2ab4a8fffbc2b" pid=1351 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/228f8a8791f8e4c0/build worker # [ 245.441497] tribuchet[1205]: 2026-08-30T17:37:18.091008Z INFO tribuchet::worker: handover requested; exiting hub # [ 665.069777] tribuchet[1132]: 2026-08-30T17:37:21.796663Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 665.073423] tribuchet[1132]: 2026-08-30T17:37:21.800322Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="c8d0dd971af7525e94d2ab4a8fffbc2b" worker # [ 250.166503] tribuchet[1380]: 2026-08-30T17:37:22.815523Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/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/1ylywfsgvg3d99q1qg5ar26zi51dbki2-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: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock"], spawn_agents: 0, agent_uid_base: None } worker # [ 250.230624] tribuchet[1380]: 2026-08-30T17:37:22.881268Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 250.241644] tribuchet[1380]: 2026-08-30T17:37:22.892323Z INFO tribuchet::worker::resume: adopted running build id="c8d0dd971af7525e94d2ab4a8fffbc2b" pid=1351 worker # [ 250.250331] nix-daemon[1072]: accepted connection from pid 1380, user tribuchet (trusted) hub # [ 665.716269] tribuchet[1132]: 2026-08-30T17:37:22.443209Z 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 # [ 665.723195] tribuchet[1132]: 2026-08-30T17:37:22.443427Z INFO tribuchet::hub: dispatching build id="c8d0dd971af7525e94d2ab4a8fffbc2b" worker="worker" worker # [ 250.300856] tribuchet[1380]: 2026-08-30T17:37:22.951499Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 250.306864] tribuchet[1380]: 2026-08-30T17:37:22.957555Z INFO tribuchet::worker::session: build resumed id="c8d0dd971af7525e94d2ab4a8fffbc2b" key="eeb25ba64970c1b3f083cf39ab640ed48fdbfeb5e351586c1ecd07ba88ef6223" hub # [ 665.750578] tribuchet[1132]: 2026-08-30T17:37:22.477784Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="c8d0dd971af7525e94d2ab4a8fffbc2b" [e2e] heartbeat t=150s hub # [ 669.407230] systemd[1273]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 670.342906] systemd[1273]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 258.483916] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:31.134209Z INFO tribuchet::worker::agent: builder exited code=137 worker # [ 258.489220] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:31.139828Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 258.701440] tribuchet[1380]: 2026-08-30T17:37:31.351497Z INFO tribuchet::worker::build::agent_exec: builder finished id="c8d0dd971af7525e94d2ab4a8fffbc2b" exit_code=137 aborted=Some("build log exceeded the limit of 1048576 bytes") worker # [ 258.718266] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1344]: 2026-08-30T17:37:31.368732Z INFO tribuchet::worker::agent: cleanup done id="c8d0dd971af7525e94d2ab4a8fffbc2b" worker # [ 258.762527] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1396]: 2026-08-30T17:37:31.412415Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 258.769979] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1396]: 2026-08-30T17:37:31.420432Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 258.784695] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1396]: 2026-08-30T17:37:31.420516Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 258.789226] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1396]: 2026-08-30T17:37:31.421205Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 258.849499] tribuchet[1380]: 2026-08-30T17:37:31.500062Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="c8d0dd971af7525e94d2ab4a8fffbc2b" worker # [ 258.872242] tribuchet[1380]: 2026-08-30T17:37:31.522869Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="c8d0dd971af7525e94d2ab4a8fffbc2b" hub # [ 674.705573] systemd[1]: slowlogbuild.service: Main process exited, code=exited, status=100/n/a hub # [ 674.710949] systemd[1]: slowlogbuild.service: Failed with result 'exit-code'. hub # [ 684.875990] tribuchet[1132]: 2026-08-30T17:37:41.601870Z INFO tribuchet::hub::submit: queueing build id="6e43214cdc4df1cfe5713fc321123160" system="x86_64-linux" hub # [ 684.881080] tribuchet[1132]: 2026-08-30T17:37:41.601945Z INFO tribuchet::hub: dispatching build id="6e43214cdc4df1cfe5713fc321123160" worker="worker" hub # [ 684.942607] tribuchet[1132]: 2026-08-30T17:37:41.669928Z INFO tribuchet::hub::relay::staging: input path negotiation done id="6e43214cdc4df1cfe5713fc321123160" total=7 missing=0 worker # [ 269.489960] tribuchet[1380]: 2026-08-30T17:37:42.139951Z INFO tribuchet::worker::session: build assigned id="6e43214cdc4df1cfe5713fc321123160" worker # [ 269.498857] nix-daemon[1072]: accepted connection from pid 1380, user tribuchet (trusted) worker # [ 269.509060] tribuchet[1380]: 2026-08-30T17:37:42.159676Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="6e43214cdc4df1cfe5713fc321123160" fixed_output=false network=false net_isolation=false worker # [ 269.548430] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:37:42.198743Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 269.553514] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:37:42.204201Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 269.558116] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:37:42.208751Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 269.572188] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:37:42.221173Z INFO tribuchet::worker::agent: builder started id="6e43214cdc4df1cfe5713fc321123160" pid=1514 worker # [ 269.577873] tribuchet[1380]: 2026-08-30T17:37:42.221268Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="6e43214cdc4df1cfe5713fc321123160" pid=1514 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/fcfa8a18995bf650/build worker # [ 279.558326] tribuchet[1380]: 2026-08-30T17:37:52.208128Z INFO tribuchet::worker: handover requested; exiting hub # [ 695.021725] tribuchet[1132]: 2026-08-30T17:37:51.748256Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 695.057631] tribuchet[1132]: 2026-08-30T17:37:51.748324Z WARN tribuchet::hub: dispatch lost, requeueing build: worker disconnected or went silent id="6e43214cdc4df1cfe5713fc321123160" worker # [ 279.708553] tribuchet[1555]: 2026-08-30T17:37:52.358833Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/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/1ylywfsgvg3d99q1qg5ar26zi51dbki2-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: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock"], spawn_agents: 0, agent_uid_base: None } worker # [ 279.743579] tribuchet[1555]: 2026-08-30T17:37:52.394229Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 279.824893] tribuchet[1555]: 2026-08-30T17:37:52.456923Z INFO tribuchet::worker::resume: adopted running build id="6e43214cdc4df1cfe5713fc321123160" pid=1514 worker # [ 279.923596] nix-daemon[1072]: accepted connection from pid 1555, user tribuchet (trusted) hub # [ 695.742684] tribuchet[1132]: 2026-08-30T17:37:52.469722Z 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 # [ 280.319149] tribuchet[1555]: 2026-08-30T17:37:52.969806Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] worker # [ 280.369331] tribuchet[1555]: 2026-08-30T17:37:53.019426Z INFO tribuchet::worker::session: build resumed id="6e43214cdc4df1cfe5713fc321123160" key="1666e3028dcde1399ddc8b367ed9088e5fe8f7ff46affbf2548857108c7f0d6c" hub # [ 695.772826] tribuchet[1132]: 2026-08-30T17:37:52.469862Z INFO tribuchet::hub: dispatching build id="6e43214cdc4df1cfe5713fc321123160" worker="worker" hub # [ 695.840831] tribuchet[1132]: 2026-08-30T17:37:52.567338Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="6e43214cdc4df1cfe5713fc321123160" hub # [ 696.720963] systemd[1346]: Failed to adjust io pressure threshold, ignoring: Device or resource busy [e2e] heartbeat t=180s hub # [ 697.437259] systemd[1346]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 291.299807] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:38:03.950174Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 291.310374] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:38:03.960291Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 291.500901] tribuchet[1555]: 2026-08-30T17:38:04.150400Z INFO tribuchet::worker::build::agent_exec: builder finished id="6e43214cdc4df1cfe5713fc321123160" exit_code=0 aborted=None worker # [ 291.867259] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1507]: 2026-08-30T17:38:04.508753Z INFO tribuchet::worker::agent: cleanup done id="6e43214cdc4df1cfe5713fc321123160" worker # [ 292.069391] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1578]: 2026-08-30T17:38:04.719639Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 292.080329] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1578]: 2026-08-30T17:38:04.727070Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 292.085346] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1578]: 2026-08-30T17:38:04.727152Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 292.143460] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1578]: 2026-08-30T17:38:04.729939Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 292.149494] tribuchet[1555]: 2026-08-30T17:38:04.793833Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="6e43214cdc4df1cfe5713fc321123160" worker # [ 292.159421] tribuchet[1555]: 2026-08-30T17:38:04.805609Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="6e43214cdc4df1cfe5713fc321123160" worker # [ 297.150372] systemd[1595]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 297.353183] systemd[1595]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 720.814571] tribuchet[1132]: 2026-08-30T17:38:17.540691Z INFO tribuchet::hub::submit: queueing build id="f207f503aaa738c9e192ff5598b147d1" system="x86_64-linux" hub # [ 720.819754] tribuchet[1132]: 2026-08-30T17:38:17.540758Z INFO tribuchet::hub: dispatching build id="f207f503aaa738c9e192ff5598b147d1" worker="worker" worker # [ 305.390921] tribuchet[1555]: 2026-08-30T17:38:18.041066Z INFO tribuchet::worker::session: build assigned id="f207f503aaa738c9e192ff5598b147d1" worker # [ 305.402666] nix-daemon[1072]: accepted connection from pid 1555, user tribuchet (trusted) worker # [ 305.420067] tribuchet[1555]: 2026-08-30T17:38:18.070661Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="f207f503aaa738c9e192ff5598b147d1" fixed_output=false network=false net_isolation=false hub # [ 720.846402] tribuchet[1132]: 2026-08-30T17:38:17.573731Z INFO tribuchet::hub::relay::staging: input path negotiation done id="f207f503aaa738c9e192ff5598b147d1" total=7 missing=0 worker # [ 305.617193] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1661]: 2026-08-30T17:38:18.266288Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 305.631586] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1661]: 2026-08-30T17:38:18.279687Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 305.643296] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1661]: 2026-08-30T17:38:18.282150Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 305.707281] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1661]: 2026-08-30T17:38:18.357167Z INFO tribuchet::worker::agent: builder started id="f207f503aaa738c9e192ff5598b147d1" pid=1671 worker # [ 305.714911] tribuchet[1555]: 2026-08-30T17:38:18.357246Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="f207f503aaa738c9e192ff5598b147d1" pid=1671 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/16dda93c0673c141/build hub # [ 722.161107] systemd[1]: cancelbuild.service: Main process exited, code=killed, status=9/KILL hub # [ 722.164653] systemd[1]: cancelbuild.service: Failed with result 'signal'. [e2e] heartbeat t=210s worker # [ 317.415337] tribuchet[1555]: 2026-08-30T17:38:30.065077Z INFO tribuchet::worker::session: hub cancelled the build id="f207f503aaa738c9e192ff5598b147d1" hub # [ 732.842673] tribuchet[1132]: 2026-08-30T17:38:29.569319Z INFO tribuchet::hub::relay: no attach client left; cancelling build id="f207f503aaa738c9e192ff5598b147d1" worker # [ 317.598041] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1661]: 2026-08-30T17:38:30.248386Z INFO tribuchet::worker::agent: builder exited code=137 worker # [ 317.808912] tribuchet[1555]: 2026-08-30T17:38:30.459294Z INFO tribuchet::worker::build::agent_exec: builder finished id="f207f503aaa738c9e192ff5598b147d1" exit_code=137 aborted=Some("build cancelled") worker # [ 317.854104] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1661]: 2026-08-30T17:38:30.504711Z INFO tribuchet::worker::agent: cleanup done id="f207f503aaa738c9e192ff5598b147d1" worker # [ 317.963124] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1785]: 2026-08-30T17:38:30.612151Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 317.984739] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1785]: 2026-08-30T17:38:30.631359Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 317.997386] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1785]: 2026-08-30T17:38:30.631484Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 318.029805] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1785]: 2026-08-30T17:38:30.631560Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 318.052509] tribuchet[1555]: 2026-08-30T17:38:30.699650Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="f207f503aaa738c9e192ff5598b147d1" worker # [ 318.093933] tribuchet[1555]: 2026-08-30T17:38:30.744539Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="f207f503aaa738c9e192ff5598b147d1" hub # [ 735.651111] systemd[1502]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 737.489547] systemd[1502]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 744.541442] tribuchet[1132]: 2026-08-30T17:38:41.266431Z INFO tribuchet::hub::submit: queueing build id="233fc414aedbdc087618584295ea68a5" system="x86_64-linux" hub # [ 744.555694] tribuchet[1132]: 2026-08-30T17:38:41.276267Z INFO tribuchet::hub: dispatching build id="233fc414aedbdc087618584295ea68a5" worker="worker" worker # [ 329.129572] tribuchet[1555]: 2026-08-30T17:38:41.779245Z INFO tribuchet::worker::session: build assigned id="233fc414aedbdc087618584295ea68a5" worker # [ 329.175155] nix-daemon[1072]: accepted connection from pid 1555, user tribuchet (trusted) hub # [ 744.643565] tribuchet[1132]: 2026-08-30T17:38:41.370860Z INFO tribuchet::hub::relay::staging: input path negotiation done id="233fc414aedbdc087618584295ea68a5" total=7 missing=0 worker # [ 329.223495] tribuchet[1555]: 2026-08-30T17:38:41.874114Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="233fc414aedbdc087618584295ea68a5" fixed_output=false network=false net_isolation=false worker # [ 329.278320] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1808]: 2026-08-30T17:38:41.928604Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 329.303489] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1808]: 2026-08-30T17:38:41.954152Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 329.329584] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1808]: 2026-08-30T17:38:41.979881Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 329.384404] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1808]: 2026-08-30T17:38:42.022458Z INFO tribuchet::worker::agent: builder started id="233fc414aedbdc087618584295ea68a5" pid=1815 worker # [ 329.393508] tribuchet[1555]: 2026-08-30T17:38:42.031383Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="233fc414aedbdc087618584295ea68a5" pid=1815 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/c57708449979bada/build [e2e] heartbeat t=240s worker # [ 351.992096] sched: DL replenish lagged too much [e2e] heartbeat t=270s worker # [ 376.746352] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1808]: 2026-08-30T17:39:29.392321Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 379.126540] tribuchet[1555]: 2026-08-30T17:39:29.481491Z INFO tribuchet::worker::build::agent_exec: builder finished id="233fc414aedbdc087618584295ea68a5" exit_code=0 aborted=None worker # [ 379.165259] tribuchet[1555]: 2026-08-30T17:39:29.617840Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="233fc414aedbdc087618584295ea68a5" worker # [ 379.268840] tribuchet[1555]: 2026-08-30T17:39:29.640059Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="233fc414aedbdc087618584295ea68a5" worker # [ 379.348215] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1808]: 2026-08-30T17:39:29.523736Z INFO tribuchet::worker::agent: cleanup done id="233fc414aedbdc087618584295ea68a5" worker # [ 379.898582] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1827]: 2026-08-30T17:39:29.571139Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 380.121591] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1827]: 2026-08-30T17:39:29.571264Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 380.318657] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1827]: 2026-08-30T17:39:29.571315Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 380.445500] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1827]: 2026-08-30T17:39:29.571453Z INFO tribuchet::worker::agent: no build held, exiting until the next activation hub # [ 808.185145] tribuchet[1132]: 2026-08-30T17:39:44.911650Z INFO tribuchet::hub::submit: queueing build id="e704c76f4fb5e3de76f88901511412aa" system="x86_64-linux" hub # [ 808.196412] tribuchet[1132]: 2026-08-30T17:39:44.917654Z INFO tribuchet::hub: dispatching build id="e704c76f4fb5e3de76f88901511412aa" worker="worker" worker # [ 392.793690] tribuchet[1555]: 2026-08-30T17:39:45.443569Z INFO tribuchet::worker::session: build assigned id="e704c76f4fb5e3de76f88901511412aa" worker # [ 392.816377] nix-daemon[1072]: accepted connection from pid 1555, user tribuchet (trusted) hub # [ 808.267678] tribuchet[1132]: 2026-08-30T17:39:44.994922Z INFO tribuchet::hub::relay::staging: input path negotiation done id="e704c76f4fb5e3de76f88901511412aa" total=7 missing=0 worker # [ 392.841354] tribuchet[1555]: 2026-08-30T17:39:45.488680Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="e704c76f4fb5e3de76f88901511412aa" fixed_output=false network=false net_isolation=false hub # [ 808.401586] tribuchet[1132]: 2026-08-30T17:39:45.128461Z INFO tribuchet::hub::submit: queueing build id="d049c7fe25664d0d1108ab05f6b0939b" system="x86_64-linux" hub # [ 808.414192] tribuchet[1132]: 2026-08-30T17:39:45.140743Z INFO tribuchet::hub: dispatching build id="d049c7fe25664d0d1108ab05f6b0939b" worker="worker" worker # [ 393.014537] tribuchet[1555]: 2026-08-30T17:39:45.664691Z INFO tribuchet::worker::session: build assigned id="d049c7fe25664d0d1108ab05f6b0939b" worker # [ 393.078283] nix-daemon[1072]: accepted connection from pid 1555, user tribuchet (trusted) worker # [ 393.209300] tribuchet[1555]: 2026-08-30T17:39:45.859680Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="d049c7fe25664d0d1108ab05f6b0939b" fixed_output=false network=false net_isolation=false hub # [ 808.697470] tribuchet[1132]: 2026-08-30T17:39:45.424746Z INFO tribuchet::hub::relay::staging: input path negotiation done id="d049c7fe25664d0d1108ab05f6b0939b" total=7 missing=0 worker # [ 393.526953] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1836]: 2026-08-30T17:39:46.083690Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 393.556113] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1836]: 2026-08-30T17:39:46.114186Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 393.596547] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1836]: 2026-08-30T17:39:46.114266Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 393.665077] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1836]: 2026-08-30T17:39:46.315658Z INFO tribuchet::worker::agent: builder started id="e704c76f4fb5e3de76f88901511412aa" pid=1850 worker # [ 393.723245] tribuchet[1555]: 2026-08-30T17:39:46.373142Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="e704c76f4fb5e3de76f88901511412aa" pid=1850 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/43c12c60cd3722e3/build worker # [ 393.774281] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1025]: 2026-08-30T17:39:46.416168Z INFO tribuchet::worker::agent: builder started id="d049c7fe25664d0d1108ab05f6b0939b" pid=1849 worker # [ 393.825305] tribuchet[1555]: 2026-08-30T17:39:46.470500Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="d049c7fe25664d0d1108ab05f6b0939b" pid=1849 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/4454661c554a2632/build [e2e] heartbeat t=300s worker # [ 416.761534] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1025]: 2026-08-30T17:40:09.411720Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 416.766685] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1836]: 2026-08-30T17:40:09.416265Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 416.842489] tribuchet[1555]: 2026-08-30T17:40:09.492602Z INFO tribuchet::worker::build::agent_exec: builder finished id="d049c7fe25664d0d1108ab05f6b0939b" exit_code=0 aborted=None worker # [ 416.848304] tribuchet[1555]: 2026-08-30T17:40:09.498920Z INFO tribuchet::worker::build::agent_exec: builder finished id="e704c76f4fb5e3de76f88901511412aa" exit_code=0 aborted=None worker # [ 416.899365] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1025]: 2026-08-30T17:40:09.548346Z INFO tribuchet::worker::agent: cleanup done id="d049c7fe25664d0d1108ab05f6b0939b" worker # [ 416.940442] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1836]: 2026-08-30T17:40:09.588211Z INFO tribuchet::worker::agent: cleanup done id="e704c76f4fb5e3de76f88901511412aa" worker # [ 417.180179] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1871]: 2026-08-30T17:40:09.829337Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 417.189636] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1871]: 2026-08-30T17:40:09.840298Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 417.201983] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1871]: 2026-08-30T17:40:09.852615Z INFO tribuchet::worker::agent: agent listening uid=993 worker # [ 417.209099] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1871]: 2026-08-30T17:40:09.859246Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 417.253500] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1872]: 2026-08-30T17:40:09.896494Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 417.266555] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1872]: 2026-08-30T17:40:09.902383Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 417.280673] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1872]: 2026-08-30T17:40:09.903861Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 417.288470] 56an0x49k728455f00b69q8yxaxr2nnp-tribuchet-agent[1872]: 2026-08-30T17:40:09.927584Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 417.300503] tribuchet[1555]: 2026-08-30T17:40:09.950684Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="e704c76f4fb5e3de76f88901511412aa" worker # [ 417.308306] tribuchet[1555]: 2026-08-30T17:40:09.958214Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="d049c7fe25664d0d1108ab05f6b0939b" worker # [ 417.337459] tribuchet[1555]: 2026-08-30T17:40:09.988026Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="e704c76f4fb5e3de76f88901511412aa" worker # [ 417.388205] tribuchet[1555]: 2026-08-30T17:40:10.038841Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="d049c7fe25664d0d1108ab05f6b0939b" thread 'lifecycle' (153) panicked at crates/tribuchet/tests/e2e/main.rs:485:5: builds did not overlap: 30s (serial would be >=30s) note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace FAILED failures: failures: lifecycle test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 19 filtered out; finished in 315.77s !!! Test "daemon lifecycle" failed with error: "Command '['/nix/store/cgmy1z7dhvdpvsi5jswa87d1x6jq00vp-tribuchet-e2e-0.1.0/bin/tribuchet-e2e', 'lifecycle', '--nocapture', '--test-threads=1']' returned non-zero exit status 101." cleanup kill QemuMachine (pid 55) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14) kill QemuMachine (pid 54) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14) (finished: cleanup, in 20.65 seconds) Traceback (most recent call last): File "/nix/store/nfc5bblkf9sqhc9pgsxcf32m4a918y09-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in sys.exit(main()) ~~~~^^ File "/nix/store/nfc5bblkf9sqhc9pgsxcf32m4a918y09-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main driver.run_tests() ~~~~~~~~~~~~~~~~^^ File "/nix/store/nfc5bblkf9sqhc9pgsxcf32m4a918y09-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests self.test_script() ~~~~~~~~~~~~~~~~^^ File "/nix/store/nfc5bblkf9sqhc9pgsxcf32m4a918y09-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script exec(self.tests, symbols, None) ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "", line 46, in File "/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/lib/python3.14/subprocess.py", line 578, in run raise CalledProcessError(retcode, process.args, output=stdout, stderr=stderr) subprocess.CalledProcessError: Command '['/nix/store/cgmy1z7dhvdpvsi5jswa87d1x6jq00vp-tribuchet-e2e-0.1.0/bin/tribuchet-e2e', 'lifecycle', '--nocapture', '--test-threads=1']' returned non-zero exit status 101.