Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.01 seconds) start vhost-device-vsock (finished: start vhost-device-vsock, in 0.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/tmpbume_lwe/hub_host.socket worker: ssh -o User=root vsock-mux//build/tmpbume_lwe/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.6Nt6JDsEa5', 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: f0e5968e-6fd6-4e94-8132-cf8b4bdca7f1 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 48) hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC660+7EF2C660 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC660 7EF2C660 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:08.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 0.000000] Linux version 6.18.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/x64plfhrprcljfgly19vqxh4s8s332y7-nixos-system-hub-test/init regInfo=/nix/store/fpchxpizf9qjqlqx1lrc24b7s6mw99pk-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 722914612 cycles hub # [ 0.000004] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000009] tsc: Detected 3099.998 MHz processor hub # [ 0.001354] last_pfn = 0x180000 max_arch_pfn = 0x400000000 hub # [ 0.001396] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.001399] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.001457] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.004026] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.004051] Using GB pages for direct mapping hub # [ 0.004234] RAMDISK: [mem 0x7e34e000-0x7ffcffff] hub # [ 0.004251] ACPI: Early table checksum verification disabled hub # [ 0.004256] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) hub # [ 0.004261] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004268] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004277] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004281] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.004284] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004288] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004291] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004294] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.004297] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] hub # [ 0.004299] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] hub # [ 0.004300] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.004310] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] hub # [ 0.004311] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] hub # [ 0.004312] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] hub # [ 0.004312] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] hub # [ 0.004895] No NUMA configuration found hub # [ 0.004896] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] hub # [ 0.004901] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff] hub # [ 0.005027] Zone ranges: hub # [ 0.005029] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005031] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] hub # [ 0.005033] Normal [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005035] Device empty hub # [ 0.005036] Movable zone start for each node hub # [ 0.005037] Early memory node ranges hub # [ 0.005037] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005039] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.005040] node 0: [mem 0x0000000100000000-0x000000017fffffff] hub # [ 0.005042] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] hub # [ 0.005067] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.005401] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.118383] On node 0, zone Normal: 40 pages in unavailable ranges hub # [ 0.119607] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.119630] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.119668] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.119674] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.119678] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.119680] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.119681] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.119682] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.119686] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.119687] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.119694] TSC deadline timer available hub # [ 0.119701] CPU topo: Max. logical packages: 1 hub # [ 0.119702] CPU topo: Max. logical dies: 1 hub # [ 0.119703] CPU topo: Max. dies per package: 1 hub # [ 0.119708] CPU topo: Max. threads per core: 1 hub # [ 0.119709] CPU topo: Num. cores per package: 1 hub # [ 0.119710] CPU topo: Num. threads per package: 1 hub # [ 0.119710] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.119735] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.119773] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.119775] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.119777] PM: hibernation: Registered nosave memory: [mem 0x7ffd8000-0xffffffff] hub # [ 0.119779] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.119781] Booting paravirtualized kernel on KVM hub # [ 0.119786] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.125375] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.128371] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.128445] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.128448] 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/x64plfhrprcljfgly19vqxh4s8s332y7-nixos-system-hub-test/init regInfo=/nix/store/fpchxpizf9qjqlqx1lrc24b7s6mw99pk-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.128568] Unknown kernel command line parameters "regInfo=/nix/store/fpchxpizf9qjqlqx1lrc24b7s6mw99pk-closure-info/registration", will be passed to user space. hub # [ 0.128588] random: crng init done hub # [ 0.128589] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.133419] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) hub # [ 0.135850] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.135923] software IO TLB: area num 1. hub # [ 0.236881] Fallback order for Node 0: 0 hub # [ 0.236894] Built 1 zonelists, mobility grouping on. Total pages: 1048438 hub # [ 0.236897] Policy zone: Normal hub # [ 0.240236] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.253076] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.263724] allocated 8388608 bytes of page_ext hub # [ 0.275151] ftrace: allocating 48717 entries in 192 pages hub # [ 0.275159] ftrace: allocated 192 pages with 2 groups hub # [ 0.276440] Dynamic Preempt: lazy hub # [ 0.276662] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.276663] rcu: RCU event tracing is enabled. hub # [ 0.276663] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.276665] Trampoline variant of Tasks RCU enabled. hub # [ 0.276665] Rude variant of Tasks RCU enabled. hub # [ 0.276666] Tracing variant of Tasks RCU enabled. hub # [ 0.276666] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.276667] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.276687] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.276688] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.276689] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.282232] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.282569] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.282579] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.282696] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.289285] Console: colour VGA+ 80x25 hub # [ 0.289290] printk: legacy console [tty0] enabled hub # [ 0.335432] printk: legacy console [ttyS0] enabled hub # [ 0.522367] ACPI: Core revision 20250807 hub # [ 0.523907] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.526642] APIC: Switch to symmetric I/O mode setup hub # [ 0.528398] x2apic enabled hub # [ 0.529663] APIC: Switched APIC routing to: physical x2apic hub # [ 0.534972] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.537046] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.540355] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) hub # [ 0.543459] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.545489] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.546347] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.548359] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.550352] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.552347] Spectre V2 : Mitigation: Retpolines hub # [ 0.554348] RETBleed: Mitigation: untrained return thunk hub # [ 0.555348] Speculative Return Stack Overflow: Mitigation: SMT disabled hub # [ 0.557348] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.559347] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT hub # [ 0.561350] Spectre V2 : Enabling Speculation Barrier for firmware calls hub # [ 0.562348] active return thunk: retbleed_return_thunk hub # [ 0.564354] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.565385] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.567349] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.568349] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.569348] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.571348] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. hub # [ 0.606852] Freeing SMP alternatives memory: 44K hub # [ 0.607351] pid_max: default: 32768 minimum: 301 hub # [ 0.609398] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.610464] landlock: Up and running. hub # [ 0.612135] Yama: becoming mindful. hub # [ 0.613465] LSM support for eBPF active hub # [ 0.614585] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.616455] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) hub # [ 0.620544] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) hub # [ 0.622196] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.623357] ... version: 0 hub # [ 0.624349] ... bit width: 48 hub # [ 0.625349] ... generic counters: 6 hub # [ 0.626349] ... generic bitmap: 000000000000003f hub # [ 0.627349] ... fixed-purpose counters: 0 hub # [ 0.628349] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.629349] ... value mask: 0000ffffffffffff hub # [ 0.630359] ... max period: 00007fffffffffff hub # [ 0.631349] ... global_ctrl mask: 000000000000003f hub # [ 0.632473] signal: max sigframe size: 1776 hub # [ 0.633539] rcu: Hierarchical SRCU implementation. hub # [ 0.634349] rcu: Max phase no-delay instances is 400. hub # [ 0.640237] smp: Bringing up secondary CPUs ... hub # [ 0.641376] smp: Brought up 1 node, 1 CPU hub # [ 0.642353] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) hub # [ 0.643695] Memory: 3962264K/4193752K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 217764K reserved, 0K cma-reserved) hub # [ 0.645285] devtmpfs: initialized hub # [ 0.646509] x86/mm: Memory block size: 128MB hub # [ 0.648948] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.650397] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.651551] pinctrl core: initialized pinctrl subsystem hub # [ 0.652772] PM: RTC time: 04:05:30, date: 2026-08-27 hub # [ 0.656587] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.659003] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.660448] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.662284] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.663410] audit: initializing netlink subsys (disabled) hub # [ 0.665026] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.665029] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.666356] audit: type=2000 audit(1787803531.181:1): state=initialized audit_enabled=0 res=1 hub # [ 0.668355] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.668357] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.669350] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.670447] cpuidle: using governor menu hub # [ 0.673585] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.674820] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.675355] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.676377] PCI: Using configuration type 1 for base access hub # [ 0.677768] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.682760] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.683352] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.684351] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.691355] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.701772] ACPI: Added _OSI(Module Device) hub # [ 0.702350] ACPI: Added _OSI(Processor Device) hub # [ 0.707354] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.716884] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.722979] ACPI: Interpreter enabled hub # [ 0.723376] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.728154] ACPI: Using IOAPIC for interrupt routing hub # [ 0.729605] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.732350] PCI: Using E820 reservations for host bridge windows hub # [ 0.733771] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.744634] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.745363] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.746450] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.747479] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.749177] PCI host bridge to bus 0000:00 hub # [ 0.750312] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.751352] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.752354] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.753352] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.754369] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.755364] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] hub # [ 0.756355] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.757786] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.759528] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.763420] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.764401] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.765416] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.766663] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.768720] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.771377] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.772369] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.773404] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] hub # [ 0.774366] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.778813] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.782397] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.783370] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.784410] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] hub # [ 0.788221] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.791388] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.792369] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.793413] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] hub # [ 0.795766] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.798391] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.799368] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.800409] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] hub # [ 0.804464] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.807387] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.808371] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.809406] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] hub # [ 0.811813] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.814380] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.815368] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.816405] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] hub # [ 0.819403] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.822371] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.823367] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.824403] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] hub # [ 0.825365] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.827728] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.831383] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.832474] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] hub # [ 0.834900] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.838372] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.839370] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.840409] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] hub # [ 0.842803] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.846384] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] hub # [ 0.847366] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.848406] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] hub # [ 0.851183] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.854390] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.855439] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] hub # [ 0.857842] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.861040] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] hub # [ 0.863330] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.866421] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] hub # [ 0.869203] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.872426] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] hub # [ 0.874187] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.877368] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.879207] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.881067] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.883079] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.886422] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] hub # [ 0.887366] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] hub # [ 0.889228] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.892420] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.900521] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.901517] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.902630] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.903515] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.904503] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.905496] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.906611] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.907503] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.908427] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.909378] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.910477] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.911375] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.912374] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.913383] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.914376] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.915421] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.917880] iommu: Default domain type: Translated hub # [ 0.918362] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.919723] ACPI: bus type USB registered hub # [ 0.920410] usbcore: registered new interface driver usbfs hub # [ 0.921391] usbcore: registered new interface driver hub hub # [ 0.922369] usbcore: registered new device driver usb hub # [ 0.924692] NetLabel: Initializing hub # [ 0.925349] NetLabel: domain hash size = 128 hub # [ 0.926350] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.927428] NetLabel: unlabeled traffic allowed by default hub # [ 0.928369] PCI: Using ACPI for IRQ routing hub # [ 1.039528] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 1.040344] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 1.040344] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 1.040370] vgaarb: loaded hub # [ 1.041618] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 1.042355] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 1.046524] clocksource: Switched to clocksource kvm-clock hub # [ 1.051087] VFS: Disk quotas dquot_6.6.0 hub # [ 1.052201] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 1.055305] pnp: PnP ACPI init hub # [ 1.056603] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 1.058242] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 1.060904] pnp: PnP ACPI: found 6 devices hub # [ 1.069366] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 1.071845] clocksource: Switched to clocksource acpi_pm hub # [ 1.073434] NET: Registered PF_INET protocol family hub # [ 1.075718] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) hub # [ 1.097394] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) hub # [ 1.100219] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 1.102556] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 1.106489] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) hub # [ 1.108952] TCP: Hash tables configured (established 32768 bind 32768) hub # [ 1.111099] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) hub # [ 1.113444] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 1.115667] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) hub # [ 1.117989] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 1.119676] NET: Registered PF_XDP protocol family hub # [ 1.121842] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 1.124220] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 1.126136] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 1.128174] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 1.130127] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 1.131961] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] hub # [ 1.135102] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 1.138488] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 1.141504] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 1.144508] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 1.148289] PCI: CLS 0 bytes, default 64 hub # [ 1.149685] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) hub # [ 1.152143] Trying to unpack rootfs image as initramfs... hub # [ 1.161052] software IO TLB: mapped [mem 0x000000007a34e000-0x000000007e34e000] (64MB) hub # [ 1.167154] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 1.210327] Initialise system trusted keyrings hub # [ 1.216874] workingset: timestamp_bits=40 max_order=20 bucket_order=0 hub # [ 1.246895] Key type asymmetric registered hub # [ 1.285889] Asymmetric key parser 'x509' registered hub # [ 1.287564] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 1.318157] io scheduler mq-deadline registered hub # [ 1.321900] io scheduler kyber registered hub # [ 1.329865] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 1.332559] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 1.341361] Linux agpgart interface v0.103 hub # [ 1.347084] ACPI: bus type drm_connector registered hub # [ 1.369115] usbcore: registered new interface driver usbserial_generic hub # [ 1.371683] usbserial: USB Serial support registered for generic hub # [ 1.374340] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 1.377340] drop_monitor: Initializing network drop monitor service hub # [ 1.379805] NET: Registered PF_INET6 protocol family hub # [ 1.382408] Segment Routing with IPv6 hub # [ 1.383577] In-situ OAM (IOAM) with IPv6 hub # [ 1.385476] IPI shorthand broadcast: enabled hub # [ 1.389755] sched_clock: Marking stable (1138029091, 250766134)->(1660169106, -271373881) hub # [ 1.400203] registered taskstats version 1 hub # [ 1.403896] Loading compiled-in X.509 certificates hub # [ 1.419835] Demotion targets for Node 0: null hub # [ 1.422882] Key type .fscrypt registered hub # [ 1.424127] Key type fscrypt-provisioning registered hub # [ 1.429012] ima: No TPM chip found, activating TPM-bypass! hub # [ 1.430515] ima: Allocated hash algorithm: sha1 hub # [ 1.433884] ima: No architecture policies found hub # [ 1.436812] PM: Magic number: 6:975:60 hub # [ 1.442539] RAS: Correctable Errors collector initialized. hub # [ 1.460094] clk: Disabling unused clocks hub # [ 1.461313] PM: genpd: Disabling unused power domains hub # [ 1.725515] Freeing initrd memory: 29192K hub # [ 1.730092] Freeing unused decrypted memory: 2028K hub # [ 1.732899] Freeing unused kernel image (initmem) memory: 3644K hub # [ 1.734390] Write protecting the kernel read-only data: 32768k hub # [ 1.736573] Freeing unused kernel image (text/rodata gap) memory: 1220K hub # [ 1.738599] Freeing unused kernel image (rodata/data gap) memory: 756K hub # [ 1.788621] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.811064] Run /init as init process hub # [ 1.829215] systemd[1]: Inserted module 'autofs4' hub # [ 1.846671] fuse: init (API version 7.45) hub # [ 1.853632] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.857190] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.862375] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.865971] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 1.902418] systemd[1]: Successfully made /usr/ read-only. hub # [ 2.239202] 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.247006] systemd[1]: Detected virtualization kvm. hub # [ 2.248413] systemd[1]: Detected architecture x86-64. hub # [ 2.249802] systemd[1]: Running in initrd. hub # [ 2.251335] systemd[1]: Initializing machine ID from random generator. hub # [ 2.253209] systemd[1]: Hostname set to . hub # [ 2.430979] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 2.469380] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 2.474052] systemd[1]: Created slice Slice /system/modprobe. hub # [ 2.475821] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 2.482094] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 2.483850] systemd[1]: Reached target Path Units. hub # [ 2.485307] systemd[1]: Reached target Slice Units. hub # [ 2.486688] systemd[1]: Reached target Swaps. hub # [ 2.488157] systemd[1]: Reached target Timer Units. hub # [ 2.489868] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 2.491700] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 2.493535] systemd[1]: Listening on Journal Sockets. hub # [ 2.495174] systemd[1]: Listening on udev Control Socket. hub # [ 2.496741] systemd[1]: Listening on udev Kernel Socket. hub # [ 2.498224] systemd[1]: Reached target Socket Units. hub # [ 2.500670] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 2.510033] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.518727] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.535094] systemd[1]: Starting Journal Service... hub # [ 2.549012] systemd[1]: Starting Load Kernel Modules... hub # [ 2.561024] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.563651] netfs: FS-Cache loaded hub # [ 2.570351] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.573367] 9pnet: Installing 9P2000 support hub # [ 2.594971] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.605694] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.614596] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.617149] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.632668] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.639673] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.650105] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.669095] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.680901] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.699927] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.746010] systemd[1]: Finished Load Kernel Modules. hub # [ 2.760104] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.788050] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.804942] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.823996] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.854018] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.859313] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.867013] systemd[1]: Reached target Local File Systems. hub # [ 2.618974] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.622713] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.626636] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.881968] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.890193] systemd[1]: Started Journal Service. hub # [ 2.665395] systemd[1]: Starting Create System Files and Directories... hub # [ 2.693939] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.703455] systemd[1]: Finished Create System Files and Directories. hub # [ 2.707093] systemd-udevd[75]: Using default interface naming scheme 'v261'. hub # [ 2.724747] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.726362] systemd[1]: Reached target System Initialization. hub # [ 2.728265] systemd[1]: Reached target Basic System. hub # [ 3.226597] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 3.261614] virtio_blk virtio5: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) hub # [ 3.343420] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 3.417014] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 3.418401] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 3.420596] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 hub # [ 3.430874] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 3.435311] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 3.437044] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.440988] usb usb1: Product: EHCI Host Controller hub # [ 3.443244] usb usb1: Manufacturer: Linux 6.18.44 ehci_hcd hub # [ 3.446232] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 3.449086] hub 1-0:1.0: USB hub found hub # [ 3.450803] hub 1-0:1.0: 6 ports detected hub # [ 3.456407] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 3.472206] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 3.490046] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 3.504968] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 hub # [ 3.264519] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 3.269080] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.281761] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.540380] SCSI subsystem initialized hub # [ 3.542514] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.556114] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.308280] systemd[1]: Starting Virtual Console Setup... hub # [ 3.578814] usb usb2: Product: UHCI Host Controller hub # [ 3.599795] usb usb2: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 3.351492] systemd-vconsole-setup[110]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 3.356969] systemd[1]: Finished Virtual Console Setup. hub # [ 3.613304] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 3.617190] hub 2-0:1.0: USB hub found hub # [ 3.620792] hub 2-0:1.0: 2 ports detected hub # [ 3.379317] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 3.381669] systemd[1]: Reached target Initrd Root Device. hub # [ 3.385171] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 3.637538] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 3.638654] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 3.648820] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 3.661082] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 hub # [ 3.664284] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 3.665446] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 3.672546] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.674578] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.687055] usb usb3: Product: UHCI Host Controller hub # [ 3.439402] systemd-fsck[115]: nixos: clean, 12/262144 files, 37198/1048576 blocks hub # [ 3.693817] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 3.448205] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 3.452201] systemd[1]: Mounting /sysroot... hub # [ 3.708305] usb usb3: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 3.716170] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 3.722852] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 3.749334] hub 3-0:1.0: USB hub found hub # [ 3.762221] hub 3-0:1.0: 2 ports detected hub # [ 3.787289] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 3.794382] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 3.800647] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 3.806885] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 3.824187] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 3.830029] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 hub # [ 3.839925] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 3.848880] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.857056] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.863034] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 3.865039] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 3.871826] usb 1-1: Product: QEMU USB Tablet hub # [ 3.873734] usb 1-1: Manufacturer: QEMU hub # [ 3.878795] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 3.894804] usb usb4: Product: UHCI Host Controller hub # [ 3.902886] scsi host0: ahci hub # [ 3.905101] usb usb4: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 3.913143] scsi host1: ahci hub # [ 3.919787] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 3.928082] scsi host2: ahci hub # [ 3.932187] hub 4-0:1.0: USB hub found hub # [ 3.937055] scsi host3: ahci hub # [ 3.938605] hub 4-0:1.0: 2 ports detected hub # [ 3.943879] scsi host4: ahci hub # [ 3.954022] scsi host5: ahci hub # [ 3.959258] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 44 lpm-pol 1 hub # [ 3.973152] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 44 lpm-pol 1 hub # [ 3.984387] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 44 lpm-pol 1 hub # [ 3.996557] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 44 lpm-pol 1 hub # [ 4.002419] hid: raw HID events driver (C) Jiri Kosina hub # [ 4.007226] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 44 lpm-pol 1 hub # [ 4.012560] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 44 lpm-pol 1 hub # [ 4.030038] usbcore: registered new interface driver usbhid hub # [ 4.033442] usbhid: USB HID core driver hub # [ 4.061907] EXT4-fs (vda): mounted filesystem f0e5968e-6fd6-4e94-8132-cf8b4bdca7f1 r/w with ordered data mode. Quota mode: none. hub # [ 3.815793] systemd[1]: Mounted /sysroot. hub # [ 3.817912] systemd[1]: Reached target Initrd Root File System. hub # [ 3.820608] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 3.839459] systemd-sysroot-fstab-check[147]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 3.845122] systemd[1]: Reload requested from client PID 147 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 3.849480] systemd[1]: Reloading... hub # [ 3.937918] systemd[1]: Reloading finished in 89 ms. hub # [ 3.946213] systemd-sysroot-fstab-check[147]: Requesting initrd-fs.target/start/replace... hub # [ 3.949747] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 3.952288] systemd-sysroot-fstab-check[147]: Requesting swap.target/start/replace... hub # [ 3.957166] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 3.959599] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 3.961530] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 4.325167] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 4.326603] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 4.328258] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 4.329653] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 4.330949] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 4.332343] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 4.333954] ata3.00: applying bridge limits hub # [ 4.335309] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 4.336889] ata3.00: configured for UDMA/100 hub # [ 4.338442] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 4.366972] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 hub # [ 4.372844] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 hub # [ 4.383352] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 4.397961] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 4.341827] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 4.347159] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 4.357421] systemd[1]: Mounting /sysroot/run... hub # [ 4.377334] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 4.388810] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 4.417359] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 4.418656] systemd[1]: Mounted /sysroot/run. hub # [ 4.670697] 9p: Installing v9fs 9p2000 file system support hub # [ 4.429570] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.438229] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 4.439789] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 4.442716] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 4.452760] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 4.454949] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.457793] systemd[1]: Mounting /sysroot/nix/store... hub # [ 4.482536] systemd[1]: Mounted /sysroot/nix/store. hub # [ 4.484080] systemd[1]: Reached target Initrd File Systems. hub # [ 4.486644] systemd[1]: Starting Find NixOS closure... hub # [ 4.490211] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 4.506644] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 4.515230] systemd[1]: Finished Find NixOS closure. hub # [ 4.517315] systemd[1]: Reached target Initrd Default Target. hub # [ 4.519662] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 4.538410] systemd[1]: Stopped target Initrd Default Target. hub # [ 4.541262] systemd[1]: Stopped target Basic System. hub # [ 4.543073] systemd[1]: Stopped target Initrd Root Device. hub # [ 4.544426] systemd[1]: Stopped target Path Units. hub # [ 4.545894] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 4.547636] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 4.550600] systemd[1]: Stopped target Slice Units. hub # [ 4.552573] systemd[1]: Stopped target Socket Units. hub # [ 4.554267] systemd[1]: Stopped target System Initialization. hub # [ 4.555906] systemd[1]: Stopped target Swaps. hub # [ 4.558192] systemd[1]: Stopped target Timer Units. hub # [ 4.559456] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 4.560760] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.562505] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 4.564968] systemd[1]: Stopped Find NixOS closure. hub # [ 4.566237] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 4.569335] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.571239] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 4.573099] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.574349] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 4.576233] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.578502] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.581164] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.582748] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.584356] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.585655] systemd[1]: Stopped target Local File Systems. hub # [ 4.586895] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.589179] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 4.590660] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 4.594149] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.595783] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 4.597301] systemd[1]: Stopped Virtual Console Setup. hub # [ 4.608853] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.614670] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 4.619185] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.621404] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 4.623653] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 4.625698] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.628802] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 4.631133] systemd[1]: Closed udev Control Socket. hub # [ 4.632590] systemd[1]: Starting Cleanup udev Database... hub # [ 4.634213] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.635948] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.638510] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.640333] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.641925] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.643828] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 4.657319] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.659879] systemd[1]: Finished Cleanup udev Database. hub # [ 4.661851] systemd[1]: Reached target Switch Root. hub # [ 4.664396] systemd[1]: Starting NixOS Activation... hub # [ 4.911403] initrd-nixos-activation-start[201]: booting system configuration /nix/store/x64plfhrprcljfgly19vqxh4s8s332y7-nixos-system-hub-test hub # [ 4.979400] initrd-nixos-activation-start[201]: running activation script... hub # [ 5.581159] initrd-nixos-activation-start[224]: setting up /etc... hub # [ 5.861964] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.865105] systemd[1]: Finished NixOS Activation. hub # [ 5.866957] systemd[1]: Starting Switch Root... hub # [ 5.882476] systemd[1]: Switching root. hub # [ 6.266416] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 6.496056] NET: Registered PF_VSOCK protocol family hub # [ 6.889305] 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 # [ 6.895201] systemd[1]: Detected virtualization kvm. hub # [ 6.896322] systemd[1]: Detected architecture x86-64. hub # [ 6.897491] systemd[1]: Detected first boot. hub # [ 6.900788] systemd[1]: Initializing machine ID from random generator. hub # [ 7.184399] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 7.447187] systemd[1]: Applying preset policy. hub # [ 8.034647] systemd[1]: Populated /etc with preset unit settings. hub # [ 9.069306] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 9.072077] systemd[1]: Stopped initrd-switch-root.service. hub # [ 9.077472] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 9.083699] systemd[1]: Created slice Slice /system/getty. hub # [ 9.085659] systemd[1]: Created slice User and Session Slice. hub # [ 9.087035] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 9.088602] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 9.090278] systemd[1]: Expecting device /dev/hvc0... hub # [ 9.091418] systemd[1]: Expecting device /dev/ttyS0... hub # [ 9.093768] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 9.095150] systemd[1]: Stopped target initrd-fs.target. hub # [ 9.096429] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 9.097642] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 9.099139] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 9.100597] systemd[1]: Reached target Path Units. hub # [ 9.101876] systemd[1]: Reached target Remote File Systems. hub # [ 9.103175] systemd[1]: Reached target Slice Units. hub # [ 9.104457] systemd[1]: Reached target Swaps. hub # [ 9.139221] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 9.219053] systemd[1]: Listening on Process Core Dump Socket. hub # [ 9.234206] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 9.239992] systemd[1]: Listening on Factory Reset Management. hub # [ 9.241600] systemd[1]: Listening on Hostname Service Socket. hub # [ 9.249618] systemd[1]: Starting Journal Log Access Socket... hub # [ 9.252323] systemd[1]: Listening on Journal Audit Socket. hub # [ 9.259316] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 9.262164] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 9.264250] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 9.266145] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 9.280044] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 9.282174] systemd[1]: Listening on udev Control Socket. hub # [ 9.284083] systemd[1]: Listening on udev Varlink Socket. hub # [ 9.290064] systemd[1]: Mounting Huge Pages File System... hub # [ 9.297497] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 9.305153] systemd[1]: Mounting Kernel Debug File System... hub # [ 9.316338] systemd[1]: Mounting Kernel Trace File System... hub # [ 9.330832] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 9.339001] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 9.352341] systemd[1]: Starting Load Kernel Module configfs... hub # [ 9.355614] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 9.371212] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 9.382043] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 9.414262] systemd[1]: Mounting FUSE Control File System... hub # [ 9.419260] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 9.453318] systemd[1]: Starting Journal Service... hub # [ 9.467335] systemd[1]: Starting Load Kernel Modules... hub # [ 9.480832] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 9.498991] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 9.508014] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 9.526211] systemd-journald[294]: Collecting audit messages is enabled. hub # [ 9.528867] systemd[1]: Starting Coldplug All udev Devices... hub # [ 9.566359] loop: module loaded hub # [ 9.568420] systemd[1]: Listening on Journal Log Access Socket. hub # [ 9.579890] systemd[1]: Mounted Huge Pages File System. hub # [ 9.586792] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 9.591522] systemd[1]: Mounted Kernel Debug File System. hub # [ 9.598553] systemd[1]: Started Journal Service. hub # [ 9.606772] EXT4-fs (vda): re-mounted f0e5968e-6fd6-4e94-8132-cf8b4bdca7f1. hub # [ 9.410375] systemd-oomd[296]: No swap; memory pressure usage will be degraded hub # [ 9.788025] systemd-journald[294]: Received client request to flush runtime journal. hub # [ 11.259869] (udev-worker)[435]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 11.902381] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console hub # [ 11.906147] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 11.952046] ACPI: button: Power Button [PWRF] hub # [ 11.981672] mousedev: PS/2 mouse device common for all mice hub # [ 11.984271] Console: switching to colour dummy device 80x25 hub # [ 12.028620] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 12.028623] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 12.032610] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic hub # [ 12.033760] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 hub # [ 12.038500] rtc_cmos 00:04: RTC can wake from S4 hub # [ 12.057349] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized hub # [ 12.060641] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 hub # [ 12.079338] rtc_cmos 00:04: registered as rtc0 hub # [ 12.090581] parport_pc 00:02: reported by Plug and Play ACPI hub # [ 12.093206] rtc_cmos 00:04: setting system clock to 2026-08-27T04:05:42 UTC (1787803542) hub # [ 12.094995] systemd-journald[294]: Time jumped backwards, rotating. hub # [ 12.123060] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 12.131067] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 12.258751] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt hub # [ 12.258908] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD hub # [ 12.293030] Console: switching to colour frame buffer device 160x50 hub # [ 12.316563] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 12.317288] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 12.385427] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device hub # [ 12.269685] systemd-ssh-issue[596]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. hub # [ 12.623898] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # [ 12.685488] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) hub # [ 12.698003] ppdev: user-space parallel port driver hub # [ 12.898060] kvm_amd: TSC scaling supported hub # [ 12.900306] kvm_amd: Nested Virtualization enabled hub # [ 12.902749] kvm_amd: Nested Paging enabled hub # [ 12.903491] kvm_amd: LBR virtualization supported hub # [ 12.906364] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 12.908744] kvm_amd: Virtual GIF supported hub # [ 12.979609] EDAC MC: Ver: 3.0.0 hub # connecting to host... hub # [ 13.226612] systemd-vconsole-setup[605]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 13.984766] 8021q: 802.1Q VLAN Support v1.8 hub # [ 13.985492] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 14.251754] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 14.323278] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 14.325855] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 14.331488] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 14.333007] cfg80211: failed to load regulatory.db hub # [ 14.430134] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 14.841006] NET: Registered PF_PACKET protocol family worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.4YaNIdvEZz', 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: 8b8edbdc-5d7f-4818-9b73-92ee6854ca5f worker # Superblock backups stored on blocks: worker # 32768, 98304, 163840, 229376, 294912, 819200, 884736 worker: QEMU running (pid 49) 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 22.04 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) hub: (finished: waiting for unit multi-user.target, in 0.10 seconds) worker: waiting for unit multi-user.target worker: waiting for the VM to finish booting worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) worker # worker # worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC510+7EF2C510 CA00 worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC510 7EF2C510 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)... worker # worker # worker # Booting from ROM... worker # Probing EDD (edd=off to disable)... ok[ 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/085jv7kp5b47nar4gxmgjad9vi4vjshg-nixos-system-worker-test/init regInfo=/nix/store/ylxbxn3kq00bqki038rbkjc78j3bmszx-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 589001189 cycles worker # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000007] tsc: Detected 3099.998 MHz processor worker # [ 0.000739] last_pfn = 0x180000 max_arch_pfn = 0x400000000 worker # [ 0.000766] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000768] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.000809] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.002840] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.002861] Using GB pages for direct mapping worker # [ 0.002926] RAMDISK: [mem 0x7e33b000-0x7ffcffff] worker # [ 0.002933] ACPI: Early table checksum verification disabled worker # [ 0.002937] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS ) worker # [ 0.002942] ACPI: RSDT 0x000000007FFE2433 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002947] ACPI: FACP 0x000000007FFE222B 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002953] ACPI: DSDT 0x000000007FFE0040 0021EB (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002956] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002958] ACPI: APIC 0x000000007FFE231F 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002960] ACPI: HPET 0x000000007FFE2397 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002962] ACPI: MCFG 0x000000007FFE23CF 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002964] ACPI: WAET 0x000000007FFE240B 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002966] ACPI: Reserving FACP table memory at [mem 0x7ffe222b-0x7ffe231e] worker # [ 0.002967] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe222a] worker # [ 0.002968] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002968] ACPI: Reserving APIC table memory at [mem 0x7ffe231f-0x7ffe2396] worker # [ 0.002969] ACPI: Reserving HPET table memory at [mem 0x7ffe2397-0x7ffe23ce] worker # [ 0.002969] ACPI: Reserving MCFG table memory at [mem 0x7ffe23cf-0x7ffe240a] worker # [ 0.002970] ACPI: Reserving WAET table memory at [mem 0x7ffe240b-0x7ffe2432] worker # [ 0.003374] No NUMA configuration found worker # [ 0.003375] Faking a node at [mem 0x0000000000000000-0x000000017fffffff] worker # [ 0.003380] NODE_DATA(0) allocated [mem 0x17fff8780-0x17fffdcff] worker # [ 0.003490] Zone ranges: worker # [ 0.003491] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.003493] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] worker # [ 0.003494] Normal [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.003495] Device empty worker # [ 0.003496] Movable zone start for each node worker # [ 0.003496] Early memory node ranges worker # [ 0.003497] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.003498] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.003499] node 0: [mem 0x0000000100000000-0x000000017fffffff] worker # [ 0.003500] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] worker # [ 0.003520] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.003784] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.079133] On node 0, zone Normal: 43 pages in unavailable ranges worker # [ 0.080065] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.080082] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.080107] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.080110] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.080111] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.080113] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.080114] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.080115] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.080118] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.080119] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.080126] TSC deadline timer available worker # [ 0.080132] CPU topo: Max. logical packages: 1 worker # [ 0.080133] CPU topo: Max. logical dies: 1 worker # [ 0.080133] CPU topo: Max. dies per package: 1 worker # [ 0.080137] CPU topo: Max. threads per core: 1 worker # [ 0.080137] CPU topo: Num. cores per package: 1 worker # [ 0.080138] CPU topo: Num. threads per package: 1 worker # [ 0.080138] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.080160] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.080186] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.080188] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.080189] PM: hibernation: Registered nosave memory: [mem 0x7ffd5000-0xffffffff] worker # [ 0.080190] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.080191] Booting paravirtualized kernel on KVM worker # [ 0.080196] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.084758] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.086888] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.086938] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.086940] 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/085jv7kp5b47nar4gxmgjad9vi4vjshg-nixos-system-worker-test/init regInfo=/nix/store/ylxbxn3kq00bqki038rbkjc78j3bmszx-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.087049] Unknown kernel command line parameters "regInfo=/nix/store/ylxbxn3kq00bqki038rbkjc78j3bmszx-closure-info/registration", will be passed to user space. worker # [ 0.087068] random: crng init done worker # [ 0.087068] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.091351] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) worker # [ 0.093393] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.093439] software IO TLB: area num 1. worker # [ 0.172062] Fallback order for Node 0: 0 worker # [ 0.172070] Built 1 zonelists, mobility grouping on. Total pages: 1048435 worker # [ 0.172072] Policy zone: Normal worker # [ 0.174654] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.185039] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.194301] allocated 8388608 bytes of page_ext worker # [ 0.203039] ftrace: allocating 48717 entries in 192 pages worker # [ 0.203043] ftrace: allocated 192 pages with 2 groups worker # [ 0.203926] Dynamic Preempt: lazy worker # [ 0.204114] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.204114] rcu: RCU event tracing is enabled. worker # [ 0.204115] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.204116] Trampoline variant of Tasks RCU enabled. worker # [ 0.204117] Rude variant of Tasks RCU enabled. worker # [ 0.204117] Tracing variant of Tasks RCU enabled. worker # [ 0.204118] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.204119] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.204141] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.204144] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.204146] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.208767] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.209062] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.209069] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.209182] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.215392] Console: colour VGA+ 80x25 worker # [ 0.215400] printk: legacy console [tty0] enabled worker # [ 0.257028] printk: legacy console [ttyS0] enabled worker # [ 0.423274] ACPI: Core revision 20250807 worker # [ 0.424560] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.426887] APIC: Switch to symmetric I/O mode setup worker # [ 0.428366] x2apic enabled worker # [ 0.429398] APIC: Switched APIC routing to: physical x2apic worker # [ 0.431758] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.433181] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.435562] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) worker # [ 0.437647] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.439686] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.440559] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.442566] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.444562] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.445560] Spectre V2 : Mitigation: Retpolines worker # [ 0.446560] RETBleed: Mitigation: untrained return thunk worker # [ 0.447560] Speculative Return Stack Overflow: Mitigation: SMT disabled worker # [ 0.448560] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.449560] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT worker # [ 0.450560] Spectre V2 : Enabling Speculation Barrier for firmware calls worker # [ 0.451560] active return thunk: retbleed_return_thunk worker # [ 0.453564] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.454575] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.456559] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.458560] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.459560] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.461559] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. worker # [ 0.484732] Freeing SMP alternatives memory: 44K worker # [ 0.485561] pid_max: default: 32768 minimum: 301 worker # [ 0.486632] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.488597] landlock: Up and running. worker # [ 0.489500] Yama: becoming mindful. worker # [ 0.490345] LSM support for eBPF active worker # [ 0.491648] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.492634] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) worker # [ 0.496644] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) worker # [ 0.498183] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.498568] ... version: 0 worker # [ 0.499561] ... bit width: 48 worker # [ 0.500560] ... generic counters: 6 worker # [ 0.501560] ... generic bitmap: 000000000000003f worker # [ 0.502560] ... fixed-purpose counters: 0 worker # [ 0.503560] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.504560] ... value mask: 0000ffffffffffff worker # [ 0.505561] ... max period: 00007fffffffffff worker # [ 0.506561] ... global_ctrl mask: 000000000000003f worker # [ 0.507677] signal: max sigframe size: 1776 worker # [ 0.508655] rcu: Hierarchical SRCU implementation. worker # [ 0.509565] rcu: Max phase no-delay instances is 400. worker # [ 0.513984] smp: Bringing up secondary CPUs ... worker # [ 0.514585] smp: Brought up 1 node, 1 CPU worker # [ 0.515564] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) worker # [ 0.516738] Memory: 3961644K/4193740K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 217848K reserved, 0K cma-reserved) worker # [ 0.517983] devtmpfs: initialized worker # [ 0.518770] x86/mm: Memory block size: 128MB worker # [ 0.520566] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.521590] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.522646] pinctrl core: initialized pinctrl subsystem worker # [ 0.523821] PM: RTC time: 04:05:52, date: 2026-08-27 worker # [ 0.527587] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.529333] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.530663] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.532085] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.532580] audit: initializing netlink subsys (disabled) worker # [ 0.533821] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.533823] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.534561] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.535565] audit: type=2000 audit(1787803552.452:1): state=initialized audit_enabled=0 res=1 worker # [ 0.537563] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.537564] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.538579] cpuidle: using governor menu worker # [ 0.541514] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.542808] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.543564] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.544573] PCI: Using configuration type 1 for base access worker # [ 0.545718] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.550857] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.551562] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.556560] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.557561] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.567934] ACPI: Added _OSI(Module Device) worker # [ 0.568562] ACPI: Added _OSI(Processor Device) worker # [ 0.573563] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.579136] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.582705] ACPI: Interpreter enabled worker # [ 0.583610] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.584564] ACPI: Using IOAPIC for interrupt routing worker # [ 0.585647] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.588562] PCI: Using E820 reservations for host bridge windows worker # [ 0.589706] ACPI: Enabled 2 GPEs in block 00 to 3F worker # [ 0.596291] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.597567] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.598624] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.599683] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.601011] PCI host bridge to bus 0000:00 worker # [ 0.601567] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.602562] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.603562] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.604562] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.605561] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.606562] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.607563] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.608714] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.610307] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.613650] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.614588] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.615607] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.616791] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.618502] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.621586] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.622574] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.623607] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] worker # [ 0.624592] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.626583] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.629574] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.630573] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.631624] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] worker # [ 0.633727] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.636548] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.637587] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.638609] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] worker # [ 0.640625] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.643381] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.644576] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.645686] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] worker # [ 0.647677] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.650545] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.651574] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.652609] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] worker # [ 0.654637] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.657583] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.658582] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.659616] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] worker # [ 0.661704] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.664458] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.665580] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.666615] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] worker # [ 0.667579] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.669783] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.672502] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.673642] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] worker # [ 0.675625] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.678596] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.679577] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.680605] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] worker # [ 0.682667] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.686579] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f] worker # [ 0.687574] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.688610] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] worker # [ 0.690652] pci 0000:00:0c.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.692630] pci 0000:00:0c.0: BAR 1 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.693613] pci 0000:00:0c.0: BAR 4 [mem 0xe0000028000-0xe000002bfff 64bit pref] worker # [ 0.695684] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.697626] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f] worker # [ 0.698935] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.700474] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f] worker # [ 0.701875] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.703510] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f] worker # [ 0.705306] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint worker # [ 0.707589] pci 0000:00:1d.7: BAR 0 [mem 0xfebdc000-0xfebdcfff] worker # [ 0.708968] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.710424] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 0.711961] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint worker # [ 0.713629] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf] worker # [ 0.714578] pci 0000:00:1f.2: BAR 5 [mem 0xfebdd000-0xfebddfff] worker # [ 0.716153] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.719079] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] worker # [ 0.725219] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.725677] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.726682] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.727695] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.728664] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.729700] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 0.730672] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.731674] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.732608] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.733575] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.734575] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.735571] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 0.736571] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.737575] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.738576] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.739575] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 0.741589] iommu: Default domain type: Translated worker # [ 0.742572] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.743807] ACPI: bus type USB registered worker # [ 0.744599] usbcore: registered new interface driver usbfs worker # [ 0.745587] usbcore: registered new interface driver hub worker # [ 0.746571] usbcore: registered new device driver usb worker # [ 0.748283] NetLabel: Initializing worker # [ 0.748564] NetLabel: domain hash size = 128 worker # [ 0.749560] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.750602] NetLabel: unlabeled traffic allowed by default worker # [ 0.751570] PCI: Using ACPI for IRQ routing worker # [ 0.838706] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.839557] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.839557] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.839562] vgaarb: loaded worker # [ 0.840521] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.841437] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.845639] clocksource: Switched to clocksource kvm-clock worker # [ 0.849023] VFS: Disk quotas dquot_6.6.0 worker # [ 0.850026] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.851805] pnp: PnP ACPI init worker # [ 0.852800] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 0.854168] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 0.856181] pnp: PnP ACPI: found 6 devices worker # [ 0.863427] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.865473] clocksource: Switched to clocksource acpi_pm worker # [ 0.866986] NET: Registered PF_INET protocol family worker # [ 0.868954] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) worker # [ 0.884966] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) worker # [ 0.887195] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.889048] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.892022] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) worker # [ 0.893817] TCP: Hash tables configured (established 32768 bind 32768) worker # [ 0.895400] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) worker # [ 0.897212] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 0.898830] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) worker # [ 0.900637] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.901973] NET: Registered PF_XDP protocol family worker # [ 0.903178] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.904620] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.906035] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.907625] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] worker # [ 0.909174] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 0.910738] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window] worker # [ 0.913041] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 0.915141] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 0.917137] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 0.919166] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 0.921108] PCI: CLS 0 bytes, default 64 worker # [ 0.922195] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) worker # [ 0.923783] Trying to unpack rootfs image as initramfs... worker # [ 0.930559] software IO TLB: mapped [mem 0x000000007a33b000-0x000000007e33b000] (64MB) worker # [ 0.934529] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.968291] Initialise system trusted keyrings worker # [ 0.971582] workingset: timestamp_bits=40 max_order=20 bucket_order=0 worker # [ 0.998583] Key type asymmetric registered worker # [ 0.999662] Asymmetric key parser 'x509' registered worker # [ 1.003586] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 1.005677] io scheduler mq-deadline registered worker # [ 1.009547] io scheduler kyber registered worker # [ 1.011227] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 1.013195] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 1.021746] Linux agpgart interface v0.103 worker # [ 1.023048] ACPI: bus type drm_connector registered worker # [ 1.028089] usbcore: registered new interface driver usbserial_generic worker # [ 1.029686] usbserial: USB Serial support registered for generic worker # [ 1.033540] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 1.035460] drop_monitor: Initializing network drop monitor service worker # [ 1.041655] NET: Registered PF_INET6 protocol family worker # [ 1.045826] Segment Routing with IPv6 worker # [ 1.046870] In-situ OAM (IOAM) with IPv6 worker # [ 1.049922] IPI shorthand broadcast: enabled worker # [ 1.055090] sched_clock: Marking stable (833023657, 221488644)->(1187891433, -133379132) worker # [ 1.062755] registered taskstats version 1 worker # [ 1.064158] Loading compiled-in X.509 certificates worker # [ 1.080533] Demotion targets for Node 0: null worker # [ 1.082017] Key type .fscrypt registered worker # [ 1.085529] Key type fscrypt-provisioning registered worker # [ 1.086949] ima: No TPM chip found, activating TPM-bypass! worker # [ 1.089525] ima: Allocated hash algorithm: sha1 worker # [ 1.090736] ima: No architecture policies found worker # [ 1.094699] PM: Magic number: 6:975:60 worker # [ 1.098670] RAS: Correctable Errors collector initialized. worker # [ 1.107886] clk: Disabling unused clocks worker # [ 1.112531] PM: genpd: Disabling unused power domains worker # [ 1.312968] Freeing initrd memory: 29268K worker # [ 1.316899] Freeing unused decrypted memory: 2028K worker # [ 1.319660] Freeing unused kernel image (initmem) memory: 3644K worker # [ 1.321187] Write protecting the kernel read-only data: 32768k worker # [ 1.323287] Freeing unused kernel image (text/rodata gap) memory: 1220K worker # [ 1.325228] Freeing unused kernel image (rodata/data gap) memory: 756K worker # [ 1.362335] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.363843] Run /init as init process worker # [ 1.374115] systemd[1]: Inserted module 'autofs4' worker # [ 1.390994] fuse: init (API version 7.45) worker # [ 1.397181] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.400369] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.404190] ACPI: \_SB_.GSIE: Enabled at IRQ 20 worker # [ 1.407191] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.438049] systemd[1]: Successfully made /usr/ read-only. worker # [ 1.774373] 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 # [ 1.781093] systemd[1]: Detected virtualization kvm. worker # [ 1.782449] systemd[1]: Detected architecture x86-64. worker # [ 1.783766] systemd[1]: Running in initrd. worker # [ 1.785181] systemd[1]: Initializing machine ID from random generator. worker # [ 1.786883] systemd[1]: Hostname set to . worker # [ 1.962341] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.008796] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 2.014199] systemd[1]: Created slice Slice /system/modprobe. worker # [ 2.016138] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 2.022773] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 2.024346] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 2.025896] systemd[1]: Reached target Path Units. worker # [ 2.027196] systemd[1]: Reached target Slice Units. worker # [ 2.028460] systemd[1]: Reached target Swaps. worker # [ 2.029693] systemd[1]: Reached target Timer Units. worker # [ 2.031139] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 2.032900] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 2.034655] systemd[1]: Listening on Journal Sockets. worker # [ 2.036044] systemd[1]: Listening on udev Control Socket. worker # [ 2.037516] systemd[1]: Listening on udev Kernel Socket. worker # [ 2.038862] systemd[1]: Reached target Socket Units. worker # [ 2.041142] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 2.045911] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 2.057165] systemd[1]: Starting Load Kernel Module configfs... worker # [ 2.067163] systemd[1]: Starting Journal Service... worker # [ 2.081806] systemd[1]: Starting Load Kernel Modules... worker # [ 2.088655] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.094679] netfs: FS-Cache loaded worker # [ 2.105230] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.117309] 9pnet: Installing 9P2000 support worker # [ 2.131214] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.142373] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 2.145409] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.157235] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.166118] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.173125] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.179999] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.185384] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.190675] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.203753] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 2.231699] systemd[1]: Finished Load Kernel Modules. worker # [ 2.245679] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.259772] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.272957] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.290785] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.309275] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.314838] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.321629] systemd[1]: Reached target Local File Systems. worker # [ 2.331631] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.344756] systemd[1]: Started Journal Service. worker # [ 2.124760] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 2.126691] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 2.129370] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.147061] systemd[1]: Starting Create System Files and Directories... worker # [ 2.180144] systemd[1]: Finished Create System Files and Directories. worker # [ 2.184793] systemd-udevd[75]: Using default interface naming scheme 'v261'. worker # [ 2.191476] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.207127] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.208786] systemd[1]: Reached target System Initialization. worker # [ 2.210166] systemd[1]: Reached target Basic System. worker # [ 2.676607] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.682302] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.720735] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 2.721863] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 worker # [ 2.724359] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdc000 worker # [ 2.733538] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 2.736580] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 2.738249] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.739855] virtio_blk virtio4: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) worker # [ 2.743191] usb usb1: Product: EHCI Host Controller worker # [ 2.746721] usb usb1: Manufacturer: Linux 6.18.44 ehci_hcd worker # [ 2.748516] usb usb1: SerialNumber: 0000:00:1d.7 worker # [ 2.751190] hub 1-0:1.0: USB hub found worker # [ 2.753519] hub 1-0:1.0: 6 ports detected worker # [ 2.755765] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.773104] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.776795] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 2.780183] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.795218] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 worker # [ 2.797112] virtio_blk virtio5: [vdb] 2573264 512-byte logical blocks (1.32 GB/1.23 GiB) worker # [ 2.806458] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 2.809641] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c240 worker # [ 2.821906] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.840817] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.621804] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.624894] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.849259] SCSI subsystem initialized worker # [ 2.853269] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.861146] usb usb2: Product: UHCI Host Controller worker # [ 2.648391] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.655097] systemd[1]: Starting Virtual Console Setup... worker # [ 2.883940] usb usb2: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 2.687099] systemd-vconsole-setup[109]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.692560] systemd[1]: Finished Virtual Console Setup. worker # [ 2.916536] usb usb2: SerialNumber: 0000:00:1d.0 worker # [ 2.923802] hub 2-0:1.0: USB hub found worker # [ 2.930195] hub 2-0:1.0: 2 ports detected worker # [ 2.937543] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 2.938678] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 2.728706] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.954160] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 2.957114] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c260 worker # [ 2.739223] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.740773] systemd[1]: Reached target Initrd Root Device. worker # [ 2.744522] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.968700] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.975744] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.978507] usb usb3: Product: UHCI Host Controller worker # [ 2.979411] usb usb3: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 2.987506] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 2.991523] usb 1-1: new high-speed USB device number 2 using ehci-pci worker # [ 2.997892] hub 3-0:1.0: USB hub found worker # [ 3.000908] hub 3-0:1.0: 2 ports detected worker # [ 2.782623] systemd-fsck[116]: nixos: clean, 12/262144 files, 37198/1048576 blocks worker # [ 2.789521] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 3.016147] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 3.019577] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 3.022656] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 3.024762] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 3.026107] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c280 worker # [ 3.029903] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 3.032358] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.034066] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 3.037242] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.039332] scsi host0: ahci worker # [ 3.040326] scsi host1: ahci worker # [ 3.041825] scsi host2: ahci worker # [ 3.047512] usb usb4: Product: UHCI Host Controller worker # [ 3.048412] usb usb4: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 3.050142] scsi host3: ahci worker # [ 3.053773] scsi host4: ahci worker # [ 3.055522] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 3.057302] scsi host5: ahci worker # [ 3.058083] ata1: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd100 irq 44 lpm-pol 1 worker # [ 3.060620] hub 4-0:1.0: USB hub found worker # [ 3.064869] hub 4-0:1.0: 2 ports detected worker # [ 3.066899] ata2: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd180 irq 44 lpm-pol 1 worker # [ 3.076428] ata3: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd200 irq 44 lpm-pol 1 worker # [ 3.083238] ata4: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd280 irq 44 lpm-pol 1 worker # [ 3.089219] ata5: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd300 irq 44 lpm-pol 1 worker # [ 3.092034] ata6: SATA max UDMA/133 abar m4096@0xfebdd000 port 0xfebdd380 irq 44 lpm-pol 1 worker # [ 2.902345] systemd[1]: Mounting /sysroot... worker # [ 3.126584] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.128171] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.131288] usb 1-1: Product: QEMU USB Tablet worker # [ 3.132659] usb 1-1: Manufacturer: QEMU worker # [ 3.133404] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 3.156305] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.406157] ata2: SATA link down (SStatus 0 SControl 300) worker # [ 3.407409] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 3.408670] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 3.409875] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 3.411094] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.412683] ata3.00: applying bridge limits worker # [ 3.413687] ata3.00: configured for UDMA/100 worker # [ 3.414828] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 3.416080] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 3.417620] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.467770] usbcore: registered new interface driver usbhid worker # [ 3.475519] usbhid: USB HID core driver worker # [ 3.498124] 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.504192] 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.509639] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.519799] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.539404] EXT4-fs (vda): mounted filesystem 8b8edbdc-5d7f-4818-9b73-92ee6854ca5f r/w with ordered data mode. Quota mode: none. worker # [ 3.327289] systemd[1]: Mounted /sysroot. worker # [ 3.329240] systemd[1]: Reached target Initrd Root File System. worker # [ 3.335660] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 3.341871] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.344156] systemd[1]: Mounting /sysroot/run... worker # [ 3.349603] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.361375] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 3.380629] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 3.624837] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 3.424112] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.430120] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.431663] systemd[1]: Mounted /sysroot/run. worker # [ 3.655691] 9p: Installing v9fs 9p2000 file system support worker # [ 3.439615] systemd-sysroot-fstab-check[154]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.447121] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.449219] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.454160] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.455912] systemd[1]: Reload requested from client PID 154 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.459304] systemd[1]: Reloading... worker # [ 3.539255] systemd[1]: Reloading finished in 80 ms. worker # [ 3.547516] systemd-sysroot-fstab-check[154]: Requesting initrd-fs.target/start/replace... worker # [ 3.551791] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.553532] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.556501] systemd-sysroot-fstab-check[154]: Requesting swap.target/start/replace... worker # [ 3.560783] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.562729] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.564170] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.566658] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.576750] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.579089] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.581094] systemd[1]: Mounting /sysroot/nix/store... worker # [ 3.602510] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.604047] systemd[1]: Reached target Initrd File Systems. worker # [ 3.605789] systemd[1]: Starting Find NixOS closure... worker # [ 3.608533] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 3.621956] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 3.628461] systemd[1]: Finished Find NixOS closure. worker # [ 3.630254] systemd[1]: Reached target Initrd Default Target. worker # [ 3.631919] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 3.648580] systemd[1]: Stopped target Initrd Default Target. worker # [ 3.650337] systemd[1]: Stopped target Basic System. worker # [ 3.652166] systemd[1]: Stopped target Initrd Root Device. worker # [ 3.653293] systemd[1]: Stopped target Path Units. worker # [ 3.654323] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 3.656171] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 3.658203] systemd[1]: Stopped target Slice Units. worker # [ 3.659700] systemd[1]: Stopped target Socket Units. worker # [ 3.662265] systemd[1]: Stopped target System Initialization. worker # [ 3.663392] systemd[1]: Stopped target Swaps. worker # [ 3.664318] systemd[1]: Stopped target Timer Units. worker # [ 3.665335] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 3.666506] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 3.667890] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 3.669456] systemd[1]: Stopped Find NixOS closure. worker # [ 3.670829] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 3.673191] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.674500] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 3.676154] systemd[1]: Stopped Apply Kernel Variables. worker # [ 3.678304] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 3.679879] systemd[1]: Stopped Load Kernel Modules. worker # [ 3.681259] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 3.683221] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 3.685205] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 3.686608] systemd[1]: Stopped Create System Files and Directories. worker # [ 3.688329] systemd[1]: Stopped target Local File Systems. worker # [ 3.690369] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 3.692640] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 3.694241] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 3.699226] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 3.700668] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 3.702071] systemd[1]: Stopped Virtual Console Setup. worker # [ 3.708989] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 3.711760] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 3.714583] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.716658] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.721099] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 3.722993] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 3.726182] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 3.727706] systemd[1]: Closed udev Control Socket. worker # [ 3.729278] systemd[1]: Starting Cleanup udev Database... worker # [ 3.730955] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 3.732531] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 3.733827] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 3.736169] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 3.737639] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 3.738963] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 3.750635] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 3.753071] systemd[1]: Finished Cleanup udev Database. worker # [ 3.755310] systemd[1]: Reached target Switch Root. worker # [ 3.756934] systemd[1]: Starting NixOS Activation... worker # [ 3.805877] initrd-nixos-activation-start[204]: booting system configuration /nix/store/085jv7kp5b47nar4gxmgjad9vi4vjshg-nixos-system-worker-test worker # [ 3.823255] initrd-nixos-activation-start[204]: running activation script... worker # [ 3.963818] initrd-nixos-activation-start[227]: setting up /etc... worker # [ 4.033293] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.037155] systemd[1]: Finished NixOS Activation. worker # [ 4.039609] systemd[1]: Starting Switch Root... worker # [ 4.058042] systemd[1]: Switching root. worker # [ 4.402808] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 4.467027] NET: Registered PF_VSOCK protocol family worker # [ 4.821340] 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 # [ 4.833080] systemd[1]: Detected virtualization kvm. worker # [ 4.834131] systemd[1]: Detected architecture x86-64. worker # [ 4.835371] systemd[1]: Detected first boot. worker # [ 4.836785] systemd[1]: Initializing machine ID from random generator. worker # [ 5.029093] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 5.160158] systemd[1]: Applying preset policy. worker # [ 5.232837] systemd[1]: Populated /etc with preset unit settings. worker # [ 5.324210] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.326323] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.330195] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.332775] systemd[1]: Created slice Slice /system/getty. worker # [ 5.334541] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 5.336317] systemd[1]: Created slice User and Session Slice. worker # [ 5.337620] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 5.339287] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.340910] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.341975] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.343115] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.344322] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.345404] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.346642] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.347891] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.349258] systemd[1]: Reached target Path Units. worker # [ 5.350309] systemd[1]: Reached target Remote File Systems. worker # [ 5.351559] systemd[1]: Reached target Slice Units. worker # [ 5.352656] systemd[1]: Reached target Swaps. worker # [ 5.354665] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.357249] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.359378] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.361908] systemd[1]: Listening on Factory Reset Management. worker # [ 5.363397] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.367072] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.369198] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.371240] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 5.372766] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.374310] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.376359] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 5.379748] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.381359] systemd[1]: Listening on udev Control Socket. worker # [ 5.382656] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.386727] systemd[1]: Mounting Huge Pages File System... worker # [ 5.392932] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 5.399791] systemd[1]: Mounting Kernel Debug File System... worker # [ 5.410641] systemd[1]: Mounting Kernel Trace File System... worker # [ 5.422567] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 5.432629] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 5.446792] systemd[1]: Starting Load Kernel Module configfs... worker # [ 5.448568] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 5.451956] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 5.454243] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.460552] systemd[1]: Mounting FUSE Control File System... worker # [ 5.463217] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 5.473577] systemd[1]: Starting Journal Service... worker # [ 5.478546] systemd[1]: Starting Load Kernel Modules... worker # [ 5.482663] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 5.490556] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 5.492567] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.499680] systemd[1]: Starting Coldplug All udev Devices... worker # [ 5.505601] systemd[1]: Listening on Journal Log Access Socket. worker # [ 5.508440] systemd[1]: Mounted Huge Pages File System. worker # [ 5.510670] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 5.513680] systemd[1]: Mounted Kernel Debug File System. worker # [ 5.516736] systemd[1]: Mounted Kernel Trace File System. worker # [ 5.520590] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 5.522831] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 5.529542] systemd[1]: Finished Load Kernel Module configfs. worker # [ 5.532650] systemd[1]: Mounted FUSE Control File System. worker # [ 5.539555] systemd[1]: Mounting Kernel Configuration File System... worker # [ 5.552628] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 5.560673] systemd[1]: Mounted Kernel Configuration File System. worker # [ 5.569423] EXT4-fs (vda): re-mounted 8b8edbdc-5d7f-4818-9b73-92ee6854ca5f. worker # [ 5.576757] loop: module loaded worker # [ 5.583939] systemd-journald[297]: Collecting audit messages is enabled. worker # [ 5.585799] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 5.588933] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 5.592620] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 5.603596] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 5.606572] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.612591] systemd[1]: Finished Load Kernel Modules. worker # [ 5.620595] systemd[1]: Starting Firewall... worker # [ 5.628629] systemd[1]: Starting Apply Kernel Variables... worker # [ 5.668411] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 5.678593] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 5.692398] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 5.694804] systemd[1]: Reached target First Boot Complete. worker # [ 5.710211] systemd[1]: Finished Apply Kernel Variables. worker # [ 5.719614] systemd[1]: Started Journal Service. worker # [ 5.531333] systemd-oomd[299]: No swap; memory pressure usage will be degraded worker # [ 5.794260] systemd-journald[297]: Received client request to flush runtime journal. worker # [ 6.078513] (udev-worker)[366]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 6.744250] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.766640] mousedev: PS/2 mouse device common for all mice worker # [ 6.790548] ACPI: button: Power Button [PWRF] worker # [ 6.839674] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 6.871062] rtc_cmos 00:04: RTC can wake from S4 worker # [ 6.739733] systemd-ssh-issue[529]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs. worker # [ 6.906130] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 6.945690] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 worker # [ 6.969693] rtc_cmos 00:04: registered as rtc0 worker # [ 6.969802] rtc_cmos 00:04: setting system clock to 2026-08-27T04:05:58 UTC (1787803558) worker # [ 6.969899] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # connecting to host... worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 7.81 seconds) worker: (finished: waiting for the VM to finish booting, in 7.81 seconds) worker # [ 6.971695] systemd-journald[297]: Time jumped backwards, rotating. worker # [ 6.986291] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 6.986393] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 6.990357] Console: switching to colour dummy device 80x25 worker # [ 7.475896] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 7.476592] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 7.528915] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 7.555569] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 7.556590] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 7.572940] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 7.621213] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 7.622923] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 7.899155] 8021q: 802.1Q VLAN Support v1.8 worker # [ 7.899186] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.053224] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 8.057816] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.057931] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.058647] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.058654] cfg80211: failed to load regulatory.db worker # [ 8.129073] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.274814] ppdev: user-space parallel port driver worker # [ 8.283185] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 8.295736] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 8.412565] Console: switching to colour frame buffer device 160x50 worker # [ 8.475421] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 8.751017] kvm_amd: TSC scaling supported worker # [ 8.753527] kvm_amd: Nested Virtualization enabled worker # [ 8.754241] kvm_amd: Nested Paging enabled worker # [ 8.757516] kvm_amd: LBR virtualization supported worker # [ 8.758200] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 8.760771] kvm_amd: Virtual GIF supported worker # [ 8.569088] systemd-vconsole-setup[778]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 8.819198] EDAC MC: Ver: 3.0.0 worker # [ 9.626882] NET: Registered PF_PACKET protocol family worker: (finished: waiting for unit multi-user.target, in 15.43 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.04 seconds) hub: must succeed: tribuchet ca issue hub --dir /root/ca hub: (finished: must succeed: tribuchet ca issue hub --dir /root/ca, in 0.02 seconds) hub: must succeed: tribuchet ca issue worker --dir /root/ca hub: (finished: must succeed: tribuchet ca issue worker --dir /root/ca, in 0.01 seconds) hub: must succeed: mkdir -p /etc/tribuchet/ca hub: (finished: must succeed: mkdir -p /etc/tribuchet/ca, in 0.02 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.02 seconds) worker: must succeed: mkdir -p /var/lib/tribuchet/tls worker: (finished: must succeed: mkdir -p /var/lib/tribuchet/tls, in 0.01 seconds) hub: must succeed: cat /root/ca/worker.crt hub: (finished: must succeed: cat /root/ca/worker.crt, in 0.02 seconds) worker: must succeed: cat > /var/lib/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBVzCB/6ADAgECAhQd4eemEvM0pMyQQsQsvFbLeNGEIDAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDgyNzA0MDYw NloXDTI4MDgyNjA0MDYwNlowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABPRe+IXBU4EiyYagwPybBTVY tahBKk17m1vBDicIYCkxNJ+LhrkBzwGFifjy0ya/70+OuN5owNWo+L4DQiyCvi6j FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNHADBEAiBtwx5vH8Gr moIaVqMlqx2MK4f+G32iTwvPq+OvEh/yygIgLUiiGD5SJ+kyFMuaa0kpnUbpDT6o pCcvykrH2kz1xDg= -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /var/lib/tribuchet/tls/worker.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBVzCB/6ADAgECAhQd4eemEvM0pMyQQsQsvFbLeNGEIDAKBggqhkjOPQQDAjAh MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDgyNzA0MDYw NloXDTI4MDgyNjA0MDYwNlowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABPRe+IXBU4EiyYagwPybBTVY tahBKk17m1vBDicIYCkxNJ+LhrkBzwGFifjy0ya/70+OuN5owNWo+L4DQiyCvi6j FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNHADBEAiBtwx5vH8Gr moIaVqMlqx2MK4f+G32iTwvPq+OvEh/yygIgLUiiGD5SJ+kyFMuaa0kpnUbpDT6o pCcvykrH2kz1xDg= -----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.02 seconds) worker: must succeed: cat > /var/lib/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgwocLKKMIOYrfFt8f F27qjdSQGVoSTgqcZwhkpnlPX0ChRANCAAT0XviFwVOBIsmGoMD8mwU1WLWoQSpN e5tbwQ4nCGApMTSfi4a5Ac8BhYn48tMmv+9PjrjeaMDVqPi+A0Isgr4u -----END PRIVATE KEY----- PEMEOF worker: (finished: must succeed: cat > /var/lib/tribuchet/tls/worker.key << 'PEMEOF' -----BEGIN PRIVATE KEY----- MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgwocLKKMIOYrfFt8f F27qjdSQGVoSTgqcZwhkpnlPX0ChRANCAAT0XviFwVOBIsmGoMD8mwU1WLWoQSpN e5tbwQ4nCGApMTSfi4a5Ac8BhYn48tMmv+9PjrjeaMDVqPi+A0Isgr4u -----END PRIVATE KEY----- PEMEOF, in 0.01 seconds) hub: must succeed: cat /root/ca/ca.crt hub: (finished: must succeed: cat /root/ca/ca.crt, in 0.02 seconds) worker: must succeed: cat > /var/lib/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBkDCCATWgAwIBAgIUBuE74kApNBM+FvTT2tPk1wjuQl4wCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA4MjcwNDA2 MDZaFw0zNjA4MjQwNDA2MDZaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAS/gVrH49OqZ36MwGkTlia9 PQ3IJTkY6dDGIyGRDaJIEGf8k5nVJOLAaVBlDXX43yQ+kFEQaYn4BZFOfyyAkxQj o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFL9LPqekggqh lI2pg5tS2QpfjfubMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSQAwRgIh AMXuxiBc7j0vArNyy+2JNKqEwh8Z9U6GxKlRWSAmVWh+AiEA2+rip5C2zh1+AUFv zWeZqoGikm17rFhC3F+WnOdzaLc= -----END CERTIFICATE----- PEMEOF worker: (finished: must succeed: cat > /var/lib/tribuchet/tls/ca.crt << 'PEMEOF' -----BEGIN CERTIFICATE----- MIIBkDCCATWgAwIBAgIUBuE74kApNBM+FvTT2tPk1wjuQl4wCgYIKoZIzj0EAwIw ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA4MjcwNDA2 MDZaFw0zNjA4MjQwNDA2MDZaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAS/gVrH49OqZ36MwGkTlia9 PQ3IJTkY6dDGIyGRDaJIEGf8k5nVJOLAaVBlDXX43yQ+kFEQaYn4BZFOfyyAkxQj o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFL9LPqekggqh lI2pg5tS2QpfjfubMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSQAwRgIh AMXuxiBc7j0vArNyy+2JNKqEwh8Z9U6GxKlRWSAmVWh+AiEA2+rip5C2zh1+AUFv zWeZqoGikm17rFhC3F+WnOdzaLc= -----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.01 seconds) (finished: subtest: certificate authority, in 0.21 seconds) subtest: worker registers at hub over mTLS hub: must succeed: systemctl start tribuchet-hub.socket hub: (finished: must succeed: systemctl start tribuchet-hub.socket, in 0.03 seconds) hub: must succeed: systemctl start tribuchet-hub hub # [ 36.102402] tribuchet[927]: 2026-08-27T04:06:06.759124Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 36.109886] tribuchet[927]: 2026-08-27T04:06:06.767190Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub: (finished: must succeed: systemctl start tribuchet-hub, in 0.07 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 14.968956] tribuchet[921]: 2026-08-27T04:06:06.720247Z 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: (finished: must succeed: systemctl start tribuchet-worker, in 0.08 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered' worker # [ 14.990315] tribuchet[921]: 2026-08-27T04:06:06.737826Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 15.019214] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[924]: 2026-08-27T04:06:06.770482Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 15.024678] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[924]: 2026-08-27T04:06:06.774760Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 15.029601] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[924]: 2026-08-27T04:06:06.774793Z INFO tribuchet::worker::agent: agent listening uid=993 worker # [ 15.055153] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[928]: 2026-08-27T04:06:06.806452Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 15.059918] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[928]: 2026-08-27T04:06:06.811185Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 15.064248] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[928]: 2026-08-27T04:06:06.811281Z INFO tribuchet::worker::agent: agent listening uid=992 hub # [ 36.294538] tribuchet[927]: 2026-08-27T04:06:06.951680Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] worker # [ 15.121059] tribuchet[921]: 2026-08-27T04:06:06.872555Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered', in 1.07 seconds) (finished: subtest: worker registers at hub over mTLS, in 1.24 seconds) subtest: worker sshd reachable for the harness backdoor hub: waiting for unit sshd.service hub: (finished: waiting for unit sshd.service, in 0.04 seconds) worker: waiting for unit sshd.service worker: (finished: waiting for unit sshd.service, in 0.02 seconds) (finished: subtest: worker sshd reachable for the harness backdoor, in 0.06 seconds) subtest: daemon lifecycle running 1 test test lifecycle ... hub # [ 37.599907] systemd[956]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 37.773633] systemd[956]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 16.890285] systemd[945]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 17.033613] systemd[945]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 39.239784] tribuchet[927]: 2026-08-27T04:06:09.896854Z INFO tribuchet::hub::submit: queueing build id="bae2845d04487f95ca0ec80b1c0209c1" system="x86_64-linux" hub # [ 39.243801] tribuchet[927]: 2026-08-27T04:06:09.900890Z INFO tribuchet::hub: dispatching build id="bae2845d04487f95ca0ec80b1c0209c1" worker="worker" worker # [ 18.045291] tribuchet[921]: 2026-08-27T04:06:09.795009Z INFO tribuchet::worker::session: build assigned id="bae2845d04487f95ca0ec80b1c0209c1" worker # [ 18.086080] nix-daemon[963]: accepted connection from pid 921, user tribuchet (trusted) hub # [ 39.301178] tribuchet[927]: 2026-08-27T04:06:09.958477Z INFO tribuchet::hub::relay::staging: input path negotiation done id="bae2845d04487f95ca0ec80b1c0209c1" total=8 missing=1 hub # [ 39.390697] nix-daemon[1022]: accepted connection from pid 927, user root (trusted) worker # [ 18.206827] nix-daemon[963]: accepted connection from pid 921, user tribuchet (trusted) worker # [ 18.216640] tribuchet[921]: 2026-08-27T04:06:09.968177Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="bae2845d04487f95ca0ec80b1c0209c1" fixed_output=false network=false net_isolation=false worker # [ 18.231571] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[928]: 2026-08-27T04:06:09.980938Z INFO tribuchet::worker::agent: builder started id="bae2845d04487f95ca0ec80b1c0209c1" pid=971 worker # [ 18.235625] tribuchet[921]: 2026-08-27T04:06:09.980997Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="bae2845d04487f95ca0ec80b1c0209c1" pid=971 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build worker # [ 18.251483] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[928]: 2026-08-27T04:06:10.003002Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 18.430124] tribuchet[921]: 2026-08-27T04:06:10.181399Z INFO tribuchet::worker::build::agent_exec: builder finished id="bae2845d04487f95ca0ec80b1c0209c1" exit_code=0 aborted=None worker # [ 18.439823] nix-daemon[963]: accepted connection from pid 921, user tribuchet (trusted) worker # [ 18.457679] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[928]: 2026-08-27T04:06:10.208960Z INFO tribuchet::worker::agent: cleanup done id="bae2845d04487f95ca0ec80b1c0209c1" worker # [ 18.498614] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[982]: 2026-08-27T04:06:10.249850Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 18.504591] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[982]: 2026-08-27T04:06:10.254797Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 18.509528] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[982]: 2026-08-27T04:06:10.254865Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 18.514196] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[982]: 2026-08-27T04:06:10.255020Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 18.537118] tribuchet[921]: 2026-08-27T04:06:10.288280Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="bae2845d04487f95ca0ec80b1c0209c1" worker # [ 18.546513] tribuchet[921]: 2026-08-27T04:06:10.296629Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="bae2845d04487f95ca0ec80b1c0209c1" hub # [ 40.117839] tribuchet[927]: 2026-08-27T04:06:10.774896Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 18.916731] tribuchet[921]: 2026-08-27T04:06:10.668215Z WARN tribuchet::worker: hub session ended: code: 'Unknown error', message: "h2 protocol error: error reading a body from connection", source: hyper::Error(Body, Error { kind: Io(Custom { kind: UnexpectedEof, error: "peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof" }) }) worker # [ 18.925226] tribuchet[921]: 2026-08-27T04:06:10.668277Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 40.134920] nix-daemon[1022]: reaped child process 1024, status = succeeded hub # [ 40.159765] tribuchet[1051]: 2026-08-27T04:06:10.814857Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 40.165082] tribuchet[1051]: 2026-08-27T04:06:10.815065Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 41.111714] tribuchet[1051]: 2026-08-27T04:06:11.768867Z INFO tribuchet::hub::submit: no capable worker yet; waiting system="x86_64-linux" hub # [ 41.127166] tribuchet[1051]: 2026-08-27T04:06:11.784478Z 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 # [ 41.134349] tribuchet[1051]: 2026-08-27T04:06:11.791617Z INFO tribuchet::hub::submit: queueing build id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" system="x86_64-linux" worker # [ 19.929987] tribuchet[921]: 2026-08-27T04:06:11.681027Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 41.138771] tribuchet[1051]: 2026-08-27T04:06:11.796105Z INFO tribuchet::hub: dispatching build id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" worker="worker" worker # [ 19.937774] tribuchet[921]: 2026-08-27T04:06:11.689119Z INFO tribuchet::worker::session: build assigned id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" worker # [ 19.943400] nix-daemon[963]: accepted connection from pid 921, user tribuchet (trusted) hub # [ 41.155354] tribuchet[1051]: 2026-08-27T04:06:11.812750Z INFO tribuchet::hub::relay::staging: input path negotiation done id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" total=7 missing=0 worker # [ 19.949633] tribuchet[921]: 2026-08-27T04:06:11.701221Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" fixed_output=false network=false net_isolation=false worker # [ 19.982270] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:11.733551Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 19.986799] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:11.737788Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 19.991251] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:11.737861Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 20.001877] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:11.752970Z INFO tribuchet::worker::agent: builder started id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" pid=1021 worker # [ 20.008204] tribuchet[921]: 2026-08-27T04:06:11.753057Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" pid=1021 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build worker # [ 20.679163] tribuchet[921]: 2026-08-27T04:06:12.429024Z INFO tribuchet::worker: handover requested; exiting hub # [ 41.890175] tribuchet[1051]: 2026-08-27T04:06:12.546895Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 41.893079] tribuchet[1051]: 2026-08-27T04:06:12.547034Z WARN tribuchet::hub: worker session lost; requeueing build: worker disconnected or went silent id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" worker # [ 20.690465] systemd[1]: tribuchet-worker.service: Consumed 41ms CPU time over 5.757s wall clock time, 19.7M memory peak, 17.5M read from disk, 4K written to disk, 7.3K incoming IP traffic, 5.5K outgoing IP traffic. worker # [ 20.733562] tribuchet[1051]: 2026-08-27T04:06:12.484890Z 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 # [ 20.750739] tribuchet[1051]: 2026-08-27T04:06:12.501980Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 20.768529] tribuchet[1051]: 2026-08-27T04:06:12.518539Z INFO tribuchet::worker::resume: adopted running build id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" pid=1021 worker # [ 20.783577] nix-daemon[963]: accepted connection from pid 1051, user tribuchet (trusted) worker # [ 20.802426] tribuchet[1051]: 2026-08-27T04:06:12.552707Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 42.006909] tribuchet[1051]: 2026-08-27T04:06:12.663815Z INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range", "recursive-nix"] }, SystemCaps { system: "aarch64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }] worker # [ 20.806533] tribuchet[1051]: 2026-08-27T04:06:12.553910Z INFO tribuchet::worker::session: build resumed id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" key="94f5e20c588f3232e5c51812d8c38ef4b32fe9919099304cc99c685f9d34c593" hub # [ 42.013559] tribuchet[1051]: 2026-08-27T04:06:12.663981Z INFO tribuchet::hub: dispatching build id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" worker="worker" hub # [ 42.017857] tribuchet[1051]: 2026-08-27T04:06:12.675180Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" hub # [ 42.170776] tribuchet[1051]: 2026-08-27T04:06:12.827750Z INFO tribuchet::hub::serve: SIGTERM: exiting, builds resume against the replacement instance worker # [ 20.970397] tribuchet[1051]: 2026-08-27T04:06:12.721751Z 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 # [ 20.977264] tribuchet[1051]: 2026-08-27T04:06:12.721800Z INFO tribuchet::worker: reconnecting to hub in 1s hub # [ 42.218506] tribuchet[1109]: 2026-08-27T04:06:12.875712Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 42.222258] tribuchet[1109]: 2026-08-27T04:06:12.879121Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock worker # [ 21.977419] tribuchet[1051]: 2026-08-27T04:06:13.728540Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 43.182586] tribuchet[1109]: 2026-08-27T04:06:13.839690Z 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 # [ 44.178797] tribuchet[1109]: 2026-08-27T04:06:14.835368Z INFO tribuchet::hub::submit: queueing build id="9a776e74529107cf0e507c79b5041b31" system="x86_64-linux" worker # [ 22.974697] tribuchet[1051]: 2026-08-27T04:06:14.725900Z INFO tribuchet::worker::session: build resumed id="9a776e74529107cf0e507c79b5041b31" key="94f5e20c588f3232e5c51812d8c38ef4b32fe9919099304cc99c685f9d34c593" hub # [ 44.183543] tribuchet[1109]: 2026-08-27T04:06:14.835636Z INFO tribuchet::hub: dispatching build id="9a776e74529107cf0e507c79b5041b31" worker="worker" hub # [ 44.187120] tribuchet[1109]: 2026-08-27T04:06:14.840659Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="9a776e74529107cf0e507c79b5041b31" worker # [ 39.252363] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:31.003639Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 39.255922] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:31.006926Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 39.417196] tribuchet[1051]: 2026-08-27T04:06:31.168322Z INFO tribuchet::worker::build::agent_exec: builder finished id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" exit_code=0 aborted=None worker # [ 39.424846] nix-daemon[963]: accepted connection from pid 1051, user tribuchet (trusted) worker # [ 39.436185] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1015]: 2026-08-27T04:06:31.187071Z INFO tribuchet::worker::agent: cleanup done id="5d0b77c7f15ab4f6f3d6e1cf690bd29e" worker # [ 39.464985] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1079]: 2026-08-27T04:06:31.216356Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 39.469456] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1079]: 2026-08-27T04:06:31.216707Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 39.474198] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1079]: 2026-08-27T04:06:31.216735Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 39.479245] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1079]: 2026-08-27T04:06:31.229850Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 39.498316] tribuchet[1051]: 2026-08-27T04:06:31.249848Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="9a776e74529107cf0e507c79b5041b31" worker # [ 39.504823] tribuchet[1051]: 2026-08-27T04:06:31.256334Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="9a776e74529107cf0e507c79b5041b31" worker # [ 40.717505] systemd[1093]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 40.806696] systemd[1093]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 62.527431] tribuchet[1109]: 2026-08-27T04:06:33.184233Z INFO tribuchet::hub::submit: queueing build id="0002a1c66504c65c66dc353ba9e4dfb9" system="x86_64-linux" worker # [ 41.322754] tribuchet[1051]: 2026-08-27T04:06:33.073880Z INFO tribuchet::worker::session: build assigned id="0002a1c66504c65c66dc353ba9e4dfb9" hub # [ 62.531369] tribuchet[1109]: 2026-08-27T04:06:33.184671Z INFO tribuchet::hub: dispatching build id="0002a1c66504c65c66dc353ba9e4dfb9" worker="worker" worker # [ 41.328605] nix-daemon[963]: accepted connection from pid 1051, user tribuchet (trusted) worker # [ 41.336250] tribuchet[1051]: 2026-08-27T04:06:33.086601Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="0002a1c66504c65c66dc353ba9e4dfb9" fixed_output=false network=false net_isolation=false hub # [ 62.547140] tribuchet[1109]: 2026-08-27T04:06:33.204455Z INFO tribuchet::hub::relay::staging: input path negotiation done id="0002a1c66504c65c66dc353ba9e4dfb9" total=7 missing=0 worker # [ 41.360138] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1113]: 2026-08-27T04:06:33.111479Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 41.364210] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1113]: 2026-08-27T04:06:33.115463Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 41.368155] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1113]: 2026-08-27T04:06:33.115495Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 41.376337] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1113]: 2026-08-27T04:06:33.127906Z INFO tribuchet::worker::agent: builder started id="0002a1c66504c65c66dc353ba9e4dfb9" pid=1119 worker # [ 41.382213] tribuchet[1051]: 2026-08-27T04:06:33.133369Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="0002a1c66504c65c66dc353ba9e4dfb9" pid=1119 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build [e2e] heartbeat t=30s worker # [ 61.253420] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1113]: 2026-08-27T04:06:53.004317Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 61.400370] tribuchet[1051]: 2026-08-27T04:06:53.151284Z INFO tribuchet::worker::build::agent_exec: builder finished id="0002a1c66504c65c66dc353ba9e4dfb9" exit_code=0 aborted=None worker # [ 61.410806] nix-daemon[963]: accepted connection from pid 1051, user tribuchet (trusted) worker # [ 61.428280] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1113]: 2026-08-27T04:06:53.179833Z INFO tribuchet::worker::agent: cleanup done id="0002a1c66504c65c66dc353ba9e4dfb9" worker # [ 61.472642] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1136]: 2026-08-27T04:06:53.223859Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 61.477740] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1136]: 2026-08-27T04:06:53.228845Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 61.482943] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1136]: 2026-08-27T04:06:53.228918Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 61.487690] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1136]: 2026-08-27T04:06:53.233385Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 61.525392] tribuchet[1051]: 2026-08-27T04:06:53.276825Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="0002a1c66504c65c66dc353ba9e4dfb9" worker # [ 61.531260] tribuchet[1051]: 2026-08-27T04:06:53.282813Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="0002a1c66504c65c66dc353ba9e4dfb9" worker # [ 61.761714] systemd[1149]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 61.859082] systemd[1149]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 83.516499] tribuchet[1109]: 2026-08-27T04:06:54.173631Z INFO tribuchet::hub::submit: queueing build id="3bbad2aed29b37de6858f517d199f92e" system="x86_64-linux" hub # [ 83.520593] tribuchet[1109]: 2026-08-27T04:06:54.177478Z INFO tribuchet::hub: dispatching build id="3bbad2aed29b37de6858f517d199f92e" worker="worker" worker # [ 62.316674] tribuchet[1051]: 2026-08-27T04:06:54.067809Z INFO tribuchet::worker::session: build assigned id="3bbad2aed29b37de6858f517d199f92e" worker # [ 62.324259] nix-daemon[963]: accepted connection from pid 1051, user tribuchet (trusted) hub # [ 83.538979] tribuchet[1109]: 2026-08-27T04:06:54.196364Z INFO tribuchet::hub::relay::staging: input path negotiation done id="3bbad2aed29b37de6858f517d199f92e" total=7 missing=0 worker # [ 62.333649] tribuchet[1051]: 2026-08-27T04:06:54.085187Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="3bbad2aed29b37de6858f517d199f92e" fixed_output=false network=false net_isolation=false worker # [ 62.371705] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:06:54.122777Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 62.378307] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:06:54.122837Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 62.383766] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:06:54.122884Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 62.395750] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:06:54.146931Z INFO tribuchet::worker::agent: builder started id="3bbad2aed29b37de6858f517d199f92e" pid=1190 worker # [ 62.402234] tribuchet[1051]: 2026-08-27T04:06:54.147009Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="3bbad2aed29b37de6858f517d199f92e" pid=1190 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build worker # [ 63.172419] tribuchet[1051]: 2026-08-27T04:06:54.922413Z INFO tribuchet::worker: handover requested; exiting hub # [ 84.381686] tribuchet[1109]: 2026-08-27T04:06:55.038795Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 84.384980] tribuchet[1109]: 2026-08-27T04:06:55.038913Z WARN tribuchet::hub: worker session lost; requeueing build: worker disconnected or went silent id="3bbad2aed29b37de6858f517d199f92e" worker # [ 63.217273] tribuchet[1219]: 2026-08-27T04:06:54.968559Z 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 # [ 63.230839] tribuchet[1219]: 2026-08-27T04:06:54.982419Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 63.245191] tribuchet[1219]: 2026-08-27T04:06:54.996329Z INFO tribuchet::worker::resume: adopted running build id="3bbad2aed29b37de6858f517d199f92e" pid=1190 worker # [ 63.257278] nix-daemon[963]: accepted connection from pid 1219, user tribuchet (trusted) worker # [ 63.274547] tribuchet[1219]: 2026-08-27T04:06:55.024623Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 84.478744] tribuchet[1109]: 2026-08-27T04:06:55.135710Z 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 # [ 84.485610] tribuchet[1109]: 2026-08-27T04:06:55.135850Z INFO tribuchet::hub: dispatching build id="3bbad2aed29b37de6858f517d199f92e" worker="worker" worker # [ 63.278969] tribuchet[1219]: 2026-08-27T04:06:55.025845Z INFO tribuchet::worker::session: build resumed id="3bbad2aed29b37de6858f517d199f92e" key="fef0bf3bfc4fa8970e3b793396e3e6174e6e6746a3d42f4e31cf273e83e8d1f0" hub # [ 84.489842] tribuchet[1109]: 2026-08-27T04:06:55.146916Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="3bbad2aed29b37de6858f517d199f92e" [e2e] heartbeat t=60s worker # [ 77.282579] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:07:09.033901Z INFO tribuchet::worker::agent: builder exited code=137 worker # [ 77.286559] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:07:09.037176Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 77.486990] tribuchet[1219]: 2026-08-27T04:07:09.238128Z INFO tribuchet::worker::build::agent_exec: builder finished id="3bbad2aed29b37de6858f517d199f92e" exit_code=137 aborted=Some("build log exceeded the limit of 1048576 bytes") worker # [ 77.496785] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1184]: 2026-08-27T04:07:09.247563Z INFO tribuchet::worker::agent: cleanup done id="3bbad2aed29b37de6858f517d199f92e" worker # [ 77.526066] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1237]: 2026-08-27T04:07:09.276386Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 77.529976] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1237]: 2026-08-27T04:07:09.276710Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 77.534195] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1237]: 2026-08-27T04:07:09.276736Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 77.539133] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1237]: 2026-08-27T04:07:09.288767Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 77.555412] tribuchet[1219]: 2026-08-27T04:07:09.306956Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="3bbad2aed29b37de6858f517d199f92e" worker # [ 77.561384] tribuchet[1219]: 2026-08-27T04:07:09.312950Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="3bbad2aed29b37de6858f517d199f92e" hub # [ 98.784788] systemd[1]: slowlogbuild.service: Main process exited, code=exited, status=100/n/a hub # [ 98.787212] systemd[1]: slowlogbuild.service: Failed with result 'exit-code'. worker # [ 78.354962] systemd[1250]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 78.445788] systemd[1250]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 100.324332] tribuchet[1109]: 2026-08-27T04:07:10.981427Z INFO tribuchet::hub::submit: queueing build id="d20657a128887a063292f850e7a5cb7b" system="x86_64-linux" hub # [ 100.328306] tribuchet[1109]: 2026-08-27T04:07:10.981527Z INFO tribuchet::hub: dispatching build id="d20657a128887a063292f850e7a5cb7b" worker="worker" worker # [ 79.123108] tribuchet[1219]: 2026-08-27T04:07:10.874414Z INFO tribuchet::worker::session: build assigned id="d20657a128887a063292f850e7a5cb7b" worker # [ 79.128594] nix-daemon[963]: accepted connection from pid 1219, user tribuchet (trusted) hub # [ 100.340252] tribuchet[1109]: 2026-08-27T04:07:10.997637Z INFO tribuchet::hub::relay::staging: input path negotiation done id="d20657a128887a063292f850e7a5cb7b" total=7 missing=0 worker # [ 79.134505] tribuchet[1219]: 2026-08-27T04:07:10.886099Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="d20657a128887a063292f850e7a5cb7b" fixed_output=false network=false net_isolation=false worker # [ 79.162412] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:10.913507Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 79.167265] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:10.913717Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 79.170524] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:10.913750Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 79.180155] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:10.929909Z INFO tribuchet::worker::agent: builder started id="d20657a128887a063292f850e7a5cb7b" pid=1303 worker # [ 79.183878] tribuchet[1219]: 2026-08-27T04:07:10.929968Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="d20657a128887a063292f850e7a5cb7b" pid=1303 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build worker # [ 80.089668] tribuchet[1219]: 2026-08-27T04:07:11.839285Z INFO tribuchet::worker: handover requested; exiting hub # [ 101.299744] tribuchet[1109]: 2026-08-27T04:07:11.956915Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 101.302905] tribuchet[1109]: 2026-08-27T04:07:11.956976Z WARN tribuchet::hub: worker session lost; requeueing build: worker disconnected or went silent id="d20657a128887a063292f850e7a5cb7b" worker # [ 80.135266] tribuchet[1344]: 2026-08-27T04:07:11.885257Z 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 # [ 80.148299] tribuchet[1344]: 2026-08-27T04:07:11.885583Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 80.159969] tribuchet[1344]: 2026-08-27T04:07:11.910999Z INFO tribuchet::worker::resume: adopted running build id="d20657a128887a063292f850e7a5cb7b" pid=1303 worker # [ 80.173644] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 80.189370] tribuchet[1344]: 2026-08-27T04:07:11.940798Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 101.394109] tribuchet[1109]: 2026-08-27T04:07:12.050955Z 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 # [ 80.195167] tribuchet[1344]: 2026-08-27T04:07:11.946554Z INFO tribuchet::worker::session: build resumed id="d20657a128887a063292f850e7a5cb7b" key="3f2c2225e6fa331b165d966cc78e893e18b959df256ceb98a78449180381fe64" hub # [ 101.401857] tribuchet[1109]: 2026-08-27T04:07:12.051072Z INFO tribuchet::hub: dispatching build id="d20657a128887a063292f850e7a5cb7b" worker="worker" hub # [ 101.405505] tribuchet[1109]: 2026-08-27T04:07:12.058422Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="d20657a128887a063292f850e7a5cb7b" worker # [ 93.251432] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:25.002777Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 93.254632] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:25.005914Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 93.397154] tribuchet[1344]: 2026-08-27T04:07:25.148297Z INFO tribuchet::worker::build::agent_exec: builder finished id="d20657a128887a063292f850e7a5cb7b" exit_code=0 aborted=None worker # [ 93.404783] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 93.416144] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1297]: 2026-08-27T04:07:25.167132Z INFO tribuchet::worker::agent: cleanup done id="d20657a128887a063292f850e7a5cb7b" worker # [ 93.442867] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1366]: 2026-08-27T04:07:25.194300Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 93.446760] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1366]: 2026-08-27T04:07:25.198216Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 93.452143] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1366]: 2026-08-27T04:07:25.198242Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 93.457195] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1366]: 2026-08-27T04:07:25.207965Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 93.514762] tribuchet[1344]: 2026-08-27T04:07:25.266269Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="d20657a128887a063292f850e7a5cb7b" worker # [ 93.520393] tribuchet[1344]: 2026-08-27T04:07:25.271957Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="d20657a128887a063292f850e7a5cb7b" worker # [ 94.366397] systemd[1379]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 94.454731] systemd[1379]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 116.429326] tribuchet[1109]: 2026-08-27T04:07:27.086270Z INFO tribuchet::hub::submit: queueing build id="1ff912f690832b2251f818e1a2775f95" system="x86_64-linux" hub # [ 116.434839] tribuchet[1109]: 2026-08-27T04:07:27.086339Z INFO tribuchet::hub: dispatching build id="1ff912f690832b2251f818e1a2775f95" worker="worker" worker # [ 95.230091] tribuchet[1344]: 2026-08-27T04:07:26.980998Z INFO tribuchet::worker::session: build assigned id="1ff912f690832b2251f818e1a2775f95" worker # [ 95.236436] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 95.242746] tribuchet[1344]: 2026-08-27T04:07:26.993778Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="1ff912f690832b2251f818e1a2775f95" fixed_output=false network=false net_isolation=false hub # [ 116.453564] tribuchet[1109]: 2026-08-27T04:07:27.110945Z INFO tribuchet::hub::relay::staging: input path negotiation done id="1ff912f690832b2251f818e1a2775f95" total=7 missing=0 worker # [ 95.270309] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1423]: 2026-08-27T04:07:27.021563Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 95.276066] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1423]: 2026-08-27T04:07:27.026771Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 95.281570] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1423]: 2026-08-27T04:07:27.026837Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 95.292485] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1423]: 2026-08-27T04:07:27.044024Z INFO tribuchet::worker::agent: builder started id="1ff912f690832b2251f818e1a2775f95" pid=1429 worker # [ 95.299588] tribuchet[1344]: 2026-08-27T04:07:27.050772Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="1ff912f690832b2251f818e1a2775f95" pid=1429 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build hub # [ 117.231270] systemd[1]: cancelbuild.service: Main process exited, code=killed, status=9/KILL hub # [ 117.233905] systemd[1]: cancelbuild.service: Failed with result 'signal'. [e2e] heartbeat t=90s hub # [ 130.435969] tribuchet[1109]: 2026-08-27T04:07:41.092827Z INFO tribuchet::hub::relay: no attach client left; cancelling build id="1ff912f690832b2251f818e1a2775f95" worker # [ 109.230732] tribuchet[1344]: 2026-08-27T04:07:40.981941Z INFO tribuchet::worker::session: hub cancelled the build id="1ff912f690832b2251f818e1a2775f95" worker # [ 109.313790] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1423]: 2026-08-27T04:07:41.065147Z INFO tribuchet::worker::agent: builder exited code=137 worker # [ 109.518521] tribuchet[1344]: 2026-08-27T04:07:41.270030Z INFO tribuchet::worker::build::agent_exec: builder finished id="1ff912f690832b2251f818e1a2775f95" exit_code=137 aborted=Some("build cancelled") worker # [ 109.526439] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1423]: 2026-08-27T04:07:41.277427Z INFO tribuchet::worker::agent: cleanup done id="1ff912f690832b2251f818e1a2775f95" worker # [ 109.560237] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1666]: 2026-08-27T04:07:41.311518Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 109.565275] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1666]: 2026-08-27T04:07:41.316554Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 109.569132] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1666]: 2026-08-27T04:07:41.316614Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 109.572798] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1666]: 2026-08-27T04:07:41.323816Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 109.637952] tribuchet[1344]: 2026-08-27T04:07:41.389251Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="1ff912f690832b2251f818e1a2775f95" worker # [ 109.643215] tribuchet[1344]: 2026-08-27T04:07:41.393402Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="1ff912f690832b2251f818e1a2775f95" hub # [ 130.928644] systemd[1989]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 131.050607] systemd[1989]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 131.460296] tribuchet[1109]: 2026-08-27T04:07:42.116733Z INFO tribuchet::hub::submit: queueing build id="ec7efbd851bbbfca26202fdda16163a5" system="x86_64-linux" worker # [ 110.255082] tribuchet[1344]: 2026-08-27T04:07:42.005954Z INFO tribuchet::worker::session: build assigned id="ec7efbd851bbbfca26202fdda16163a5" hub # [ 131.464033] tribuchet[1109]: 2026-08-27T04:07:42.116793Z INFO tribuchet::hub: dispatching build id="ec7efbd851bbbfca26202fdda16163a5" worker="worker" worker # [ 110.261610] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 110.269258] tribuchet[1344]: 2026-08-27T04:07:42.020021Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="ec7efbd851bbbfca26202fdda16163a5" fixed_output=false network=false net_isolation=false hub # [ 131.481544] tribuchet[1109]: 2026-08-27T04:07:42.138893Z INFO tribuchet::hub::relay::staging: input path negotiation done id="ec7efbd851bbbfca26202fdda16163a5" total=7 missing=0 worker # [ 110.294956] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1674]: 2026-08-27T04:07:42.046336Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 110.299824] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1674]: 2026-08-27T04:07:42.050595Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 110.303340] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1674]: 2026-08-27T04:07:42.050623Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 110.313136] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1674]: 2026-08-27T04:07:42.062887Z INFO tribuchet::worker::agent: builder started id="ec7efbd851bbbfca26202fdda16163a5" pid=1680 worker # [ 110.317166] tribuchet[1344]: 2026-08-27T04:07:42.062931Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="ec7efbd851bbbfca26202fdda16163a5" pid=1680 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build [e2e] heartbeat t=120s worker # [ 140.251927] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1674]: 2026-08-27T04:08:12.003270Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 140.338968] tribuchet[1344]: 2026-08-27T04:08:12.090166Z INFO tribuchet::worker::build::agent_exec: builder finished id="ec7efbd851bbbfca26202fdda16163a5" exit_code=0 aborted=None worker # [ 140.346233] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 140.359561] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1674]: 2026-08-27T04:08:12.110499Z INFO tribuchet::worker::agent: cleanup done id="ec7efbd851bbbfca26202fdda16163a5" worker # [ 140.388091] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1695]: 2026-08-27T04:08:12.139398Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 140.393236] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1695]: 2026-08-27T04:08:12.144065Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 140.396603] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1695]: 2026-08-27T04:08:12.144114Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 140.400161] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1695]: 2026-08-27T04:08:12.151608Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 140.472786] tribuchet[1344]: 2026-08-27T04:08:12.223930Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="ec7efbd851bbbfca26202fdda16163a5" worker # [ 140.477393] tribuchet[1344]: 2026-08-27T04:08:12.228977Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="ec7efbd851bbbfca26202fdda16163a5" hub # [ 162.197623] tribuchet[1109]: 2026-08-27T04:08:12.854790Z INFO tribuchet::hub::submit: queueing build id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" system="x86_64-linux" worker # [ 140.998248] tribuchet[1344]: 2026-08-27T04:08:12.749778Z INFO tribuchet::worker::session: build assigned id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" hub # [ 162.203979] tribuchet[1109]: 2026-08-27T04:08:12.860344Z INFO tribuchet::hub: dispatching build id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" worker="worker" worker # [ 141.004821] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 141.012669] tribuchet[1344]: 2026-08-27T04:08:12.764239Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" fixed_output=false network=false net_isolation=false hub # [ 162.223883] tribuchet[1109]: 2026-08-27T04:08:12.881220Z INFO tribuchet::hub::submit: queueing build id="6281c0b73ddef7abc718892ea4492575" system="x86_64-linux" hub # [ 162.227913] tribuchet[1109]: 2026-08-27T04:08:12.884917Z INFO tribuchet::hub: dispatching build id="6281c0b73ddef7abc718892ea4492575" worker="worker" worker # [ 141.025163] tribuchet[1344]: 2026-08-27T04:08:12.776161Z INFO tribuchet::worker::session: build assigned id="6281c0b73ddef7abc718892ea4492575" hub # [ 162.231819] tribuchet[1109]: 2026-08-27T04:08:12.888930Z INFO tribuchet::hub::relay::staging: input path negotiation done id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" total=7 missing=0 worker # [ 141.033123] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 141.044675] tribuchet[1344]: 2026-08-27T04:08:12.796255Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="6281c0b73ddef7abc718892ea4492575" fixed_output=false network=false net_isolation=false hub # [ 162.256375] tribuchet[1109]: 2026-08-27T04:08:12.913721Z INFO tribuchet::hub::relay::staging: input path negotiation done id="6281c0b73ddef7abc718892ea4492575" total=7 missing=0 worker # [ 141.062277] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[924]: 2026-08-27T04:08:12.813555Z INFO tribuchet::worker::agent: builder started id="6281c0b73ddef7abc718892ea4492575" pid=1711 worker # [ 141.069194] tribuchet[1344]: 2026-08-27T04:08:12.819311Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="6281c0b73ddef7abc718892ea4492575" pid=1711 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/build worker # [ 141.081678] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1703]: 2026-08-27T04:08:12.833002Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 141.086485] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1703]: 2026-08-27T04:08:12.838049Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 141.091376] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1703]: 2026-08-27T04:08:12.842953Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 141.107823] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1703]: 2026-08-27T04:08:12.858966Z INFO tribuchet::worker::agent: builder started id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" pid=1719 worker # [ 141.113284] tribuchet[1344]: 2026-08-27T04:08:12.859039Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" pid=1719 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build worker # [ 155.252501] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[924]: 2026-08-27T04:08:27.003845Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 155.257288] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1703]: 2026-08-27T04:08:27.007917Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 155.279801] tribuchet[1344]: 2026-08-27T04:08:27.031173Z INFO tribuchet::worker::build::agent_exec: builder finished id="6281c0b73ddef7abc718892ea4492575" exit_code=0 aborted=None worker # [ 155.288237] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 155.300046] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[924]: 2026-08-27T04:08:27.051575Z INFO tribuchet::worker::agent: cleanup done id="6281c0b73ddef7abc718892ea4492575" worker # [ 155.318449] tribuchet[1344]: 2026-08-27T04:08:27.069841Z INFO tribuchet::worker::build::agent_exec: builder finished id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" exit_code=0 aborted=None worker # [ 155.330637] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 155.348198] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1703]: 2026-08-27T04:08:27.099769Z INFO tribuchet::worker::agent: cleanup done id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" worker # [ 155.356313] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1730]: 2026-08-27T04:08:27.107236Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 155.362249] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1730]: 2026-08-27T04:08:27.111794Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 155.367330] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1730]: 2026-08-27T04:08:27.111837Z INFO tribuchet::worker::agent: agent listening uid=993 worker # [ 155.372378] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1730]: 2026-08-27T04:08:27.122334Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 155.386355] tribuchet[1344]: 2026-08-27T04:08:27.137906Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="6281c0b73ddef7abc718892ea4492575" worker # [ 155.394478] tribuchet[1344]: 2026-08-27T04:08:27.145011Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="6281c0b73ddef7abc718892ea4492575" worker # [ 155.408980] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1740]: 2026-08-27T04:08:27.160357Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 155.413566] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1740]: 2026-08-27T04:08:27.164807Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 155.418136] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1740]: 2026-08-27T04:08:27.164842Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 155.421340] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1740]: 2026-08-27T04:08:27.172928Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 155.430162] tribuchet[1344]: 2026-08-27T04:08:27.181149Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" worker # [ 155.435362] tribuchet[1344]: 2026-08-27T04:08:27.186947Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="d4f42f75d4ddf5f20bfb8c13b6edaeb5" worker # [ 155.691778] systemd[1754]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 155.762674] systemd[1754]: Failed to adjust io pressure threshold, ignoring: Device or resource busy hub # [ 177.433537] tribuchet[1109]: 2026-08-27T04:08:28.090138Z INFO tribuchet::hub::submit: queueing build id="a31860248e796faa139a845e59ce1678" system="x86_64-linux" worker # [ 156.227794] tribuchet[1344]: 2026-08-27T04:08:27.979354Z INFO tribuchet::worker::session: build assigned id="a31860248e796faa139a845e59ce1678" hub # [ 177.437050] tribuchet[1109]: 2026-08-27T04:08:28.090193Z INFO tribuchet::hub: dispatching build id="a31860248e796faa139a845e59ce1678" worker="worker" worker # [ 156.243493] nix-daemon[963]: accepted connection from pid 1344, user tribuchet (trusted) worker # [ 156.253177] tribuchet[1344]: 2026-08-27T04:08:28.003123Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="a31860248e796faa139a845e59ce1678" fixed_output=false network=false net_isolation=false hub # [ 177.465781] tribuchet[1109]: 2026-08-27T04:08:28.123124Z INFO tribuchet::hub::relay::staging: input path negotiation done id="a31860248e796faa139a845e59ce1678" total=7 missing=0 worker # [ 156.281219] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:28.032507Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 156.286911] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:28.038072Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 156.292290] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:28.038123Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 156.302410] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:28.053962Z INFO tribuchet::worker::agent: builder started id="a31860248e796faa139a845e59ce1678" pid=1803 worker # [ 156.310517] tribuchet[1344]: 2026-08-27T04:08:28.061506Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="a31860248e796faa139a845e59ce1678" pid=1803 agent=/run/tribuchet/agents/2.sock scratch=/var/lib/tribuchet/a2/scratch/build worker # [ 157.051748] tribuchet[1344]: 2026-08-27T04:08:28.801684Z INFO tribuchet::worker: handover requested; exiting hub # [ 178.261812] tribuchet[1109]: 2026-08-27T04:08:28.918868Z INFO tribuchet::hub: worker disconnected worker="worker" hub # [ 178.264988] tribuchet[1109]: 2026-08-27T04:08:28.919038Z WARN tribuchet::hub: worker session lost; requeueing build: worker disconnected or went silent id="a31860248e796faa139a845e59ce1678" hub # [ 181.263435] tribuchet[1109]: 2026-08-27T04:08:31.919971Z WARN tribuchet::hub::state: failing queued build: last capable worker left id="a31860248e796faa139a845e59ce1678" hub # [ 182.627642] tribuchet[1109]: 2026-08-27T04:08:33.283971Z INFO tribuchet::hub::submit: no capable worker; declining system="x86_64-linux" worker # [ 162.092891] tribuchet[1849]: 2026-08-27T04:08:33.844247Z 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 # [ 162.108508] tribuchet[1849]: 2026-08-27T04:08:33.860082Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 162.120285] tribuchet[1849]: 2026-08-27T04:08:33.870107Z INFO tribuchet::worker::resume: adopted running build id="a31860248e796faa139a845e59ce1678" pid=1803 worker # [ 162.134836] nix-daemon[963]: accepted connection from pid 1849, user tribuchet (trusted) worker # [ 162.179935] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1859]: 2026-08-27T04:08:33.930445Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 162.183839] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1859]: 2026-08-27T04:08:33.930711Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 162.188242] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1859]: 2026-08-27T04:08:33.930740Z INFO tribuchet::worker::agent: agent listening uid=993 hub # [ 183.402447] tribuchet[1109]: 2026-08-27T04:08:34.059607Z 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 # [ 162.236914] tribuchet[1849]: 2026-08-27T04:08:33.988250Z INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux", "aarch64-linux"] hub # [ 183.482910] tribuchet[1109]: 2026-08-27T04:08:34.139848Z INFO tribuchet::hub::submit: queueing build id="4ac9f9ecde5bb5a142044c12f9e71bd6" system="x86_64-linux" worker # [ 162.278553] tribuchet[1849]: 2026-08-27T04:08:34.029857Z INFO tribuchet::worker::session: build resumed id="4ac9f9ecde5bb5a142044c12f9e71bd6" key="189d19095c5a7dc5b6cdc4185014c54b83e5834692322b8b81b010e08d905e0a" hub # [ 183.487626] tribuchet[1109]: 2026-08-27T04:08:34.139912Z INFO tribuchet::hub: dispatching build id="4ac9f9ecde5bb5a142044c12f9e71bd6" worker="worker" hub # [ 183.492657] tribuchet[1109]: 2026-08-27T04:08:34.149879Z INFO tribuchet::hub::relay: worker resumed an in-flight build id="4ac9f9ecde5bb5a142044c12f9e71bd6" [e2e] heartbeat t=150s worker # [ 186.251653] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:58.002897Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 186.255481] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:58.006434Z WARN tribuchet::worker::agent: agent request failed: sending message: Broken pipe (os error 32) worker # [ 186.367380] tribuchet[1849]: 2026-08-27T04:08:58.118535Z INFO tribuchet::worker::build::agent_exec: builder finished id="a31860248e796faa139a845e59ce1678" exit_code=0 aborted=None worker # [ 186.374895] nix-daemon[963]: accepted connection from pid 1849, user tribuchet (trusted) worker # [ 186.386867] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1797]: 2026-08-27T04:08:58.137945Z INFO tribuchet::worker::agent: cleanup done id="a31860248e796faa139a845e59ce1678" worker # [ 186.414444] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1875]: 2026-08-27T04:08:58.165758Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 186.418318] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1875]: 2026-08-27T04:08:58.165789Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 186.424689] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1875]: 2026-08-27T04:08:58.165813Z INFO tribuchet::worker::agent: agent listening uid=992 worker # [ 186.428198] scsk0d8j4a6arvxawz86rksa6ahmkdad-tribuchet-agent[1875]: 2026-08-27T04:08:58.173215Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 186.514414] tribuchet[1849]: 2026-08-27T04:08:58.265866Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="4ac9f9ecde5bb5a142044c12f9e71bd6" worker # [ 186.519141] tribuchet[1849]: 2026-08-27T04:08:58.270727Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="4ac9f9ecde5bb5a142044c12f9e71bd6" worker # [ 187.243044] systemd[1888]: Failed to adjust io pressure threshold, ignoring: Device or resource busy worker # [ 187.332752] systemd[1888]: Failed to adjust io pressure threshold, ignoring: Device or resource busy ok test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 19 filtered out; finished in 172.06s (finished: subtest: daemon lifecycle, in 172.07 seconds) (finished: run the VM test script, in 211.15 seconds) test script finished in 211.20s cleanup kill QemuMachine (pid 48) 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 49) 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 0.43 seconds)