tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script start all VMs hub: starting vm worker: starting vm hub # Disk image does not exist, creating the virtualisation disk image... hub: QEMU running (pid 47) hub # Formatting '/build/vm-state-hub/tmp.6iYc85JLzR', fmt=raw size=1073741824 hub # mke2fs 1.47.4 (6-Mar-2025) hub # Discarding device blocks: 0/262144 done hub # Creating filesystem with 262144 4k blocks and 65536 inodes hub # Filesystem UUID: 97d7f728-df81-4677-bbf9-af476b75cc1c hub # Superblock backups stored on blocks: hub # 32768, 98304, 163840, 229376 hub # hub # Allocating group tables: 0/8 done hub # Writing inode tables: 0/8 done hub # Creating journal (8192 blocks): done hub # Writing superblocks and filesystem accounting information: 0/8 done hub # hub # Virtualisation disk image created. hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1920+7EF31920 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:03.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1920 7EF31920 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:09.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 0.000000] Linux version 6.18.39 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 18 14:53:38 UTC 2026 hub # [ 0.000000] Command line: 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/v238fc49xbqqnla2zq3k3vnb2zsshslp-nixos-system-hub-test/init regInfo=/nix/store/an2z8fdalh6nzgczqvcwzm6x4wk49csj-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.000000] BIOS-provided physical RAM map: hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] 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 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 (i440FX + PIIX, 1996), 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 = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000000] kvm-clock: using sched offset of 478753104 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000005] tsc: Detected 2400.010 MHz processor hub # [ 0.000810] last_pfn = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000847] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000850] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002767] found SMP MP-table at [mem 0x000f5470-0x000f547f] hub # [ 0.002778] Using GB pages for direct mapping hub # [ 0.002903] RAMDISK: [mem 0x7e3ad000-0x7ffcffff] hub # [ 0.002910] ACPI: Early table checksum verification disabled hub # [ 0.002913] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) hub # [ 0.002916] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002920] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002927] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002929] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002930] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002932] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002934] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002935] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] hub # [ 0.002936] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] hub # [ 0.002937] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002937] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] hub # [ 0.002938] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] hub # [ 0.002938] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] hub # [ 0.003418] No NUMA configuration found hub # [ 0.003419] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] hub # [ 0.003422] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] hub # [ 0.005856] Zone ranges: hub # [ 0.005857] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005859] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] hub # [ 0.005860] Normal empty hub # [ 0.005861] Device empty hub # [ 0.005862] Movable zone start for each node hub # [ 0.005863] Early memory node ranges hub # [ 0.005863] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005864] node 0: [mem 0x0000000000100000-0x000000007ffdafff] hub # [ 0.005865] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] hub # [ 0.005889] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006166] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.043596] On node 0, zone DMA32: 37 pages in unavailable ranges hub # [ 0.044606] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.044622] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.044658] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.044661] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.044663] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.044664] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.044665] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.044666] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.044668] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.044669] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.044674] TSC deadline timer available hub # [ 0.044678] CPU topo: Max. logical packages: 1 hub # [ 0.044679] CPU topo: Max. logical dies: 1 hub # [ 0.044680] CPU topo: Max. dies per package: 1 hub # [ 0.044683] CPU topo: Max. threads per core: 1 hub # [ 0.044684] CPU topo: Num. cores per package: 1 hub # [ 0.044684] CPU topo: Num. threads per package: 1 hub # [ 0.044684] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.044707] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.044744] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.044746] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.044747] [mem 0x80000000-0xfeffbfff] available for PCI devices hub # [ 0.044749] Booting paravirtualized kernel on KVM hub # [ 0.044752] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.049254] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.051517] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.051564] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.051565] Kernel command line: 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/v238fc49xbqqnla2zq3k3vnb2zsshslp-nixos-system-hub-test/init regInfo=/nix/store/an2z8fdalh6nzgczqvcwzm6x4wk49csj-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.051658] Unknown kernel command line parameters "regInfo=/nix/store/an2z8fdalh6nzgczqvcwzm6x4wk49csj-closure-info/registration", will be passed to user space. hub # [ 0.051671] random: crng init done hub # [ 0.051672] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.053913] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.055263] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.055299] Fallback order for Node 0: 0 hub # [ 0.055302] Built 1 zonelists, mobility grouping on. Total pages: 524153 hub # [ 0.055303] Policy zone: DMA32 hub # [ 0.057871] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.061658] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.066264] allocated 4194304 bytes of page_ext hub # [ 0.076218] ftrace: allocating 48593 entries in 192 pages hub # [ 0.076220] ftrace: allocated 192 pages with 2 groups hub # [ 0.077388] Dynamic Preempt: lazy hub # [ 0.077583] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.077584] rcu: RCU event tracing is enabled. hub # [ 0.077585] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.077586] Trampoline variant of Tasks RCU enabled. hub # [ 0.077587] Rude variant of Tasks RCU enabled. hub # [ 0.077587] Tracing variant of Tasks RCU enabled. hub # [ 0.077588] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.077589] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.077612] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077614] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077615] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.081980] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.082270] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.082277] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.082387] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.089654] Console: colour VGA+ 80x25 hub # [ 0.089657] printk: legacy console [tty0] enabled hub # [ 0.131159] printk: legacy console [ttyS0] enabled hub # [ 0.320845] ACPI: Core revision 20250807 hub # [ 0.322442] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.325288] APIC: Switch to symmetric I/O mode setup hub # [ 0.327041] x2apic enabled hub # [ 0.328268] APIC: Switched APIC routing to: physical x2apic hub # [ 0.331113] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.332927] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns hub # [ 0.336007] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010) hub # [ 0.338125] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.339182] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.340006] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.341010] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.342006] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.343006] Transient Scheduler Attacks: Mitigation: Clear CPU buffers hub # [ 0.345005] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.347006] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.349006] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.351017] Spectre V2 : Enabling IBPB for BPF hub # [ 0.353007] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.354007] active return thunk: srso_alias_return_thunk hub # [ 0.356036] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.358006] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.360005] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.361005] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.362006] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.363006] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.364005] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.365006] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 0.367006] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' hub # [ 0.369006] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.370006] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.371006] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.372005] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.374005] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.376005] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 hub # [ 0.377005] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 hub # [ 0.378006] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 0.412252] Freeing SMP alternatives memory: 44K hub # [ 0.413008] pid_max: default: 32768 minimum: 301 hub # [ 0.414114] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.415130] landlock: Up and running. hub # [ 0.416006] Yama: becoming mindful. hub # [ 0.417216] LSM support for eBPF active hub # [ 0.419088] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.420055] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.422632] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.423600] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.424010] ... version: 2 hub # [ 0.425007] ... bit width: 48 hub # [ 0.426063] ... generic counters: 6 hub # [ 0.427007] ... generic bitmap: 000000000000003f hub # [ 0.428007] ... fixed-purpose counters: 0 hub # [ 0.429007] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.430007] ... value mask: 0000ffffffffffff hub # [ 0.431007] ... max period: 00007fffffffffff hub # [ 0.432007] ... global_ctrl mask: 000000000000003f hub # [ 0.433122] signal: max sigframe size: 3376 hub # [ 0.434115] rcu: Hierarchical SRCU implementation. hub # [ 0.435011] rcu: Max phase no-delay instances is 400. hub # [ 0.440568] smp: Bringing up secondary CPUs ... hub # [ 0.441023] smp: Brought up 1 node, 1 CPU hub # [ 0.442010] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) hub # [ 0.443206] Memory: 1969924K/2096612K available (17150K kernel code, 2721K rwdata, 13544K rodata, 3640K init, 3012K bss, 117256K reserved, 0K cma-reserved) hub # [ 0.444255] devtmpfs: initialized hub # [ 0.445229] x86/mm: Memory block size: 128MB hub # [ 0.447180] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.448049] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.449124] pinctrl core: initialized pinctrl subsystem hub # [ 0.450305] PM: RTC time: 13:40:33, date: 2026-08-01 hub # [ 0.453887] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.455496] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.456035] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.457300] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.458020] audit: initializing netlink subsys (disabled) hub # [ 0.459409] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.459411] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.460011] audit: type=2000 audit(1785591633.685:1): state=initialized audit_enabled=0 res=1 hub # [ 0.462011] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.462013] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.463008] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.464031] cpuidle: using governor menu hub # [ 0.467188] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.468296] PCI: Using configuration type 1 for base access hub # [ 0.469008] PCI: Using configuration type 1 for extended access hub # [ 0.470256] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.475312] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.476009] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.481008] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.482008] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.492430] ACPI: Added _OSI(Module Device) hub # [ 0.493008] ACPI: Added _OSI(Processor Device) hub # [ 0.497576] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.499823] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.506028] ACPI: Interpreter enabled hub # [ 0.507025] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.510007] ACPI: Using IOAPIC for interrupt routing hub # [ 0.511031] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.514006] PCI: Using E820 reservations for host bridge windows hub # [ 0.515166] ACPI: Enabled 2 GPEs in block 00 to 0F hub # [ 0.523509] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.524014] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.525365] acpiphp: Slot [3] registered hub # [ 0.526050] acpiphp: Slot [4] registered hub # [ 0.527063] acpiphp: Slot [5] registered hub # [ 0.528049] acpiphp: Slot [6] registered hub # [ 0.529052] acpiphp: Slot [7] registered hub # [ 0.530090] acpiphp: Slot [8] registered hub # [ 0.531065] acpiphp: Slot [9] registered hub # [ 0.532049] acpiphp: Slot [10] registered hub # [ 0.533051] acpiphp: Slot [11] registered hub # [ 0.534061] acpiphp: Slot [12] registered hub # [ 0.535049] acpiphp: Slot [13] registered hub # [ 0.536040] acpiphp: Slot [14] registered hub # [ 0.537040] acpiphp: Slot [15] registered hub # [ 0.538063] acpiphp: Slot [16] registered hub # [ 0.539041] acpiphp: Slot [17] registered hub # [ 0.540040] acpiphp: Slot [18] registered hub # [ 0.541042] acpiphp: Slot [19] registered hub # [ 0.542077] acpiphp: Slot [20] registered hub # [ 0.543041] acpiphp: Slot [21] registered hub # [ 0.544041] acpiphp: Slot [22] registered hub # [ 0.545041] acpiphp: Slot [23] registered hub # [ 0.546062] acpiphp: Slot [24] registered hub # [ 0.547040] acpiphp: Slot [25] registered hub # [ 0.548040] acpiphp: Slot [26] registered hub # [ 0.549055] acpiphp: Slot [27] registered hub # [ 0.550071] acpiphp: Slot [28] registered hub # [ 0.551062] acpiphp: Slot [29] registered hub # [ 0.552042] acpiphp: Slot [30] registered hub # [ 0.553059] acpiphp: Slot [31] registered hub # [ 0.554031] PCI host bridge to bus 0000:00 hub # [ 0.555014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.556008] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.557008] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.558009] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] hub # [ 0.559008] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] hub # [ 0.560009] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.561400] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.562935] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.564921] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint hub # [ 0.567768] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] hub # [ 0.569096] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk hub # [ 0.570008] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk hub # [ 0.571008] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk hub # [ 0.572008] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk hub # [ 0.573393] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.575073] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] hub # [ 0.577198] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint hub # [ 0.578644] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI hub # [ 0.580022] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB hub # [ 0.581448] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.584101] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.585035] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.586060] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.587250] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.589197] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.592041] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.593023] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.594061] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.595023] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.598219] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.601042] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.602022] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.603060] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.606072] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.608865] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.610022] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.611061] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.613994] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.617074] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.618023] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.619061] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.622368] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.625043] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.626022] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.627060] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.630021] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.633096] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.634091] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.635061] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.638196] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.640854] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.642023] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.643154] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.644023] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.647100] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.650057] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.651060] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.654022] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.657051] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.658023] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.659060] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.662060] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.665042] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.666022] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.667060] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.675678] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.676214] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.677220] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.678198] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.679113] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 hub # [ 0.681181] iommu: Default domain type: Translated hub # [ 0.682017] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.683294] ACPI: bus type USB registered hub # [ 0.684064] usbcore: registered new interface driver usbfs hub # [ 0.685037] usbcore: registered new interface driver hub hub # [ 0.686022] usbcore: registered new device driver usb hub # [ 0.688107] NetLabel: Initializing hub # [ 0.689008] NetLabel: domain hash size = 128 hub # [ 0.690007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.691051] NetLabel: unlabeled traffic allowed by default hub # [ 0.692022] PCI: Using ACPI for IRQ routing hub # [ 0.693640] pci 0000:00:02.0: vgaarb: setting as boot VGA device hub # [ 0.694003] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 0.694003] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.694010] vgaarb: loaded hub # [ 0.695168] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.696007] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.701090] clocksource: Switched to clocksource kvm-clock hub # [ 0.703382] VFS: Disk quotas dquot_6.6.0 hub # [ 0.706527] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.708817] pnp: PnP ACPI init hub # [ 0.710487] pnp: PnP ACPI: found 6 devices hub # [ 0.718754] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.721357] clocksource: Switched to clocksource acpi_pm hub # [ 0.723109] NET: Registered PF_INET protocol family hub # [ 0.725021] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.743662] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.746397] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.748781] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.751187] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.753446] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.755521] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.757827] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.759826] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.761993] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.763808] NET: Registered PF_XDP protocol family hub # [ 0.765353] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.767191] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.769048] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.771053] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] hub # [ 0.773053] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] hub # [ 0.775186] pci 0000:00:01.0: PIIX3: Enabling Passive Release hub # [ 0.776984] pci 0000:00:00.0: Limiting direct PCI/PCI transfers hub # [ 0.780286] ACPI: \_SB_.LNKD: Enabled at IRQ 11 hub # [ 0.783652] PCI: CLS 0 bytes, default 64 hub # [ 0.785202] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns hub # [ 0.788231] Trying to unpack rootfs image as initramfs... hub # [ 0.837015] Initialise system trusted keyrings hub # [ 0.841953] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.866998] Key type asymmetric registered hub # [ 0.868348] Asymmetric key parser 'x509' registered hub # [ 0.873823] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.878844] io scheduler mq-deadline registered hub # [ 0.880307] io scheduler kyber registered hub # [ 0.885807] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.890126] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.900948] Linux agpgart interface v0.103 hub # [ 0.902354] ACPI: bus type drm_connector registered hub # [ 0.906208] usbcore: registered new interface driver usbserial_generic hub # [ 0.908176] usbserial: USB Serial support registered for generic hub # [ 0.913797] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.913797] Please enable it if your BIOS has the CPPC option. hub # [ 0.917800] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.926918] drop_monitor: Initializing network drop monitor service hub # [ 0.928954] NET: Registered PF_INET6 protocol family hub # [ 0.935317] Segment Routing with IPv6 hub # [ 0.938810] In-situ OAM (IOAM) with IPv6 hub # [ 0.942072] IPI shorthand broadcast: enabled hub # [ 0.953237] sched_clock: Marking stable (706031655, 246726873)->(1157812416, -205053888) hub # [ 0.959912] registered taskstats version 1 hub # [ 0.961501] Loading compiled-in X.509 certificates hub # [ 0.983822] Demotion targets for Node 0: null hub # [ 0.986824] Key type .fscrypt registered hub # [ 0.990777] Key type fscrypt-provisioning registered hub # [ 0.992455] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.995777] ima: Allocated hash algorithm: sha1 hub # [ 0.997239] ima: No architecture policies found hub # [ 1.002973] PM: Magic number: 6:597:684 hub # [ 1.004323] mem full: hash matches hub # [ 1.007804] RAS: Correctable Errors collector initialized. hub # [ 1.021828] clk: Disabling unused clocks hub # [ 1.023109] PM: genpd: Disabling unused power domains hub # [ 1.161145] Freeing initrd memory: 28812K hub # [ 1.165164] Freeing unused decrypted memory: 2028K hub # [ 1.168720] Freeing unused kernel image (initmem) memory: 3640K hub # [ 1.170697] Write protecting the kernel read-only data: 32768k hub # [ 1.173556] Freeing unused kernel image (text/rodata gap) memory: 1280K hub # [ 1.176129] Freeing unused kernel image (rodata/data gap) memory: 792K hub # [ 1.229234] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.231167] Run /init as init process hub # [ 1.242501] systemd[1]: Inserted module 'autofs4' hub # [ 1.259588] fuse: init (API version 7.45) hub # [ 1.267118] ACPI: \_SB_.LNKC: Enabled at IRQ 10 hub # [ 1.275854] ACPI: \_SB_.LNKA: Enabled at IRQ 10 hub # [ 1.280545] ACPI: \_SB_.LNKB: Enabled at IRQ 11 hub # [ 1.320709] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.660212] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) hub # [ 1.681875] systemd[1]: Detected virtualization kvm. hub # [ 1.685893] systemd[1]: Detected architecture x86-64. hub # [ 1.689877] systemd[1]: Running in initrd. hub # [ 1.694187] systemd[1]: Initializing machine ID from random generator. hub # [ 1.699341] systemd[1]: Hostname set to . hub # [ 1.922344] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.982278] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.987391] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.989455] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.991952] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.993989] systemd[1]: Reached target Path Units. hub # [ 1.995598] systemd[1]: Reached target Slice Units. hub # [ 1.997233] systemd[1]: Reached target Swaps. hub # [ 1.998700] systemd[1]: Reached target Timer Units. hub # [ 2.000483] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 2.002801] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 2.004903] systemd[1]: Listening on Journal Sockets. hub # [ 2.006686] systemd[1]: Listening on udev Control Socket. hub # [ 2.008566] systemd[1]: Listening on udev Kernel Socket. hub # [ 2.010322] systemd[1]: Reached target Socket Units. hub # [ 2.013863] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 2.018877] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.029875] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.043537] systemd[1]: Starting Journal Service... hub # [ 2.055848] systemd[1]: Starting Load Kernel Modules... hub # [ 2.076523] netfs: FS-Cache loaded hub # [ 2.081802] 9pnet: Installing 9P2000 support hub # [ 2.093958] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.105989] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.123600] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.126835] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.134561] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.145039] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.150371] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.157296] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.161787] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.169427] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.179039] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.197009] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.216280] systemd[1]: Finished Load Kernel Modules. hub # [ 2.228203] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.247189] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.261146] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.282006] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.300925] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.308144] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.314891] systemd[1]: Reached target Local File Systems. hub # [ 2.324075] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.089071] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.091316] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.095469] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.344998] systemd[1]: Started Journal Service. hub # [ 2.122497] systemd[1]: Starting Create System Files and Directories... hub # [ 2.154368] systemd-udevd[75]: Using default interface naming scheme 'v261'. hub # [ 2.159760] systemd[1]: Finished Create System Files and Directories. hub # [ 2.195544] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.245189] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.246769] systemd[1]: Reached target System Initialization. hub # [ 2.248312] systemd[1]: Reached target Basic System. worker: QEMU running (pid 48) worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.7BAQm3mUSr', fmt=raw size=1073741824 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/262144 done worker # Creating filesystem with 262144 4k blocks and 65536 inodes worker # Filesystem UUID: bf2ac7f2-d13b-47a7-b248-3b2aac9822a9 worker # Superblock backups stored on blocks: worker # 32768, 98304, 163840, 229376 worker # worker # Allocating group tables: 0/8 done worker # Writing inode tables: 0/8 done worker # Creating journal (8192 blocks): done worker # Writing superblocks and filesystem accounting information: 0/8 done (finished: start all VMs, in 3.55 seconds) hub: waiting for unit headscale worker # hub: waiting for the VM to finish booting worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. hub # [ 2.788532] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # [ 2.805152] uhci_hcd 0000:00:01.2: UHCI Host Controller hub # [ 2.816649] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.839789] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 hub # [ 2.847092] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.862818] uhci_hcd 0000:00:01.2: detected 2 ports worker # worker # hub # [ 2.873383] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 hub # [ 2.875779] SCSI subsystem initialized worker # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1900+7EF31900 CA00 hub # [ 2.877355] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # Press Ctrl-B to configure iPXE (PCI 00:03.0)... worker # worker # worker # worker # hub # [ 2.886451] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1900 7EF31900 CB00 hub # [ 2.893140] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)... worker # worker # hub # [ 2.903897] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.905637] usb usb1: Product: UHCI Host Controller hub # [ 2.934494] usb usb1: Manufacturer: Linux 6.18.39 uhci_hcd hub # [ 2.689689] systemd[1]: Starting Virtual Console Setup... worker # Booting from ROM... worker # Probing EDD (edd=off to disable)... ok hub # [ 2.706171] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.709949] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.968083] usb usb1: SerialNumber: 0000:00:01.2 hub # [ 2.971878] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.737963] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.742155] systemd[1]: Finished Virtual Console Setup. hub # [ 2.993859] hub 1-0:1.0: USB hub found hub # [ 2.751636] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.004317] hub 1-0:1.0: 2 ports detected hub # [ 2.795074] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.798229] systemd[1]: Reached target Initrd Root Device. hub # [ 2.803116] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 3.062859] scsi host0: ata_piix hub # [ 3.068198] scsi host1: ata_piix hub # [ 3.071951] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 hub # [ 3.075590] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 hub # [ 2.839080] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.847068] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.872116] systemd[1]: Mounting /sysroot... hub # [ 3.234073] usb 1-1: new full-speed USB device number 2 using uhci_hcd hub # [ 3.235912] ata2: found unknown device (class 0) hub # [ 3.238307] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 3.242320] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 3.294106] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 3.313183] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 0.000000] Linux version 6.18.39 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 18 14:53:38 UTC 2026 worker # [ 0.000000] Command line: 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/rmmig3kvl5pf6y1myha3qnwr9vn6hn2j-nixos-system-worker-test/init regInfo=/nix/store/jchg3gxbymsphpzzr5gcqphpq98kc230-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 3.334601] EXT4-fs (vda): mounted filesystem 97d7f728-df81-4677-bbf9-af476b75cc1c r/w with ordered data mode. Quota mode: none. worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved hub # [ 3.094811] systemd[1]: Mounted /sysroot. worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved hub # [ 3.098106] systemd[1]: Reached target Initrd Root File System. 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 (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 hub # [ 3.102539] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 0.000000] DMI: Memory slots populated: 1/1 worker # [ 0.000000] Hypervisor detected: KVM worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000000] kvm-clock: using sched offset of 515406792 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000005] tsc: Detected 2400.010 MHz processor worker # [ 0.000810] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000847] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000850] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 3.116317] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 0.002766] found SMP MP-table at [mem 0x000f5470-0x000f547f] worker # [ 0.002777] Using GB pages for direct mapping worker # [ 0.002888] RAMDISK: [mem 0x7e39c000-0x7ffcffff] worker # [ 0.002896] ACPI: Early table checksum verification disabled worker # [ 0.002898] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) worker # [ 0.002902] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 3.124383] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 3.127210] systemd[1]: Reloading... worker # [ 0.002906] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002914] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002916] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002917] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002919] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002921] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002922] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] worker # [ 0.002923] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] worker # [ 0.002924] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002924] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] worker # [ 0.002925] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] worker # [ 0.002925] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] worker # [ 0.003419] No NUMA configuration found worker # [ 0.003420] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] worker # [ 0.003424] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] worker # [ 0.005876] Zone ranges: worker # [ 0.005877] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.005879] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] worker # [ 0.005881] Normal empty worker # [ 0.005881] Device empty worker # [ 0.005882] Movable zone start for each node hub # [ 3.403336] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 0.005883] Early memory node ranges hub # [ 3.405350] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 0.005883] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005884] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] worker # [ 0.005885] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] worker # [ 0.005906] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 3.410933] usb 1-1: Product: QEMU USB Tablet worker # [ 0.006190] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 3.413766] usb 1-1: Manufacturer: QEMU worker # [ 0.043951] On node 0, zone DMA32: 40 pages in unavailable ranges worker # [ 0.044977] ACPI: PM-Timer IO Port: 0x608 hub # [ 3.415776] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 0.044993] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.045027] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.045030] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.045032] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.045034] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.045035] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.045035] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.045038] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.045039] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.045044] TSC deadline timer available worker # [ 0.045048] CPU topo: Max. logical packages: 1 worker # [ 0.045049] CPU topo: Max. logical dies: 1 worker # [ 0.045049] CPU topo: Max. dies per package: 1 worker # [ 0.045053] CPU topo: Max. threads per core: 1 worker # [ 0.045053] CPU topo: Num. cores per package: 1 worker # [ 0.045054] CPU topo: Num. threads per package: 1 worker # [ 0.045054] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.045076] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.045122] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.045124] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.045125] [mem 0x80000000-0xfeffbfff] available for PCI devices worker # [ 0.045127] Booting paravirtualized kernel on KVM worker # [ 0.045130] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.049578] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.052117] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.052165] kvm-guest: PV spinlocks disabled, single CPU hub # [ 3.452555] hid: raw HID events driver (C) Jiri Kosina worker # [ 0.052166] Kernel command line: 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/rmmig3kvl5pf6y1myha3qnwr9vn6hn2j-nixos-system-worker-test/init regInfo=/nix/store/jchg3gxbymsphpzzr5gcqphpq98kc230-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.052264] Unknown kernel command line parameters "regInfo=/nix/store/jchg3gxbymsphpzzr5gcqphpq98kc230-closure-info/registration", will be passed to user space. worker # [ 0.052277] random: crng init done worker # [ 0.052278] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.054535] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.055685] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.055719] Fallback order for Node 0: 0 worker # [ 0.055722] Built 1 zonelists, mobility grouping on. Total pages: 524150 worker # [ 0.055723] Policy zone: DMA32 worker # [ 0.058319] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.062163] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.067109] allocated 4194304 bytes of page_ext worker # [ 0.077318] ftrace: allocating 48593 entries in 192 pages worker # [ 0.077321] ftrace: allocated 192 pages with 2 groups hub # [ 3.479944] usbcore: registered new interface driver usbhid worker # [ 0.078180] Dynamic Preempt: lazy worker # [ 0.078320] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.078321] rcu: RCU event tracing is enabled. worker # [ 0.078321] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 3.485769] usbhid: USB HID core driver worker # [ 0.078323] Trampoline variant of Tasks RCU enabled. worker # [ 0.078323] Rude variant of Tasks RCU enabled. worker # [ 0.078323] Tracing variant of Tasks RCU enabled. worker # [ 0.078324] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.078325] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.078379] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.078381] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.078382] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.082795] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.083071] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.083078] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 3.503974] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 0.083181] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.090466] Console: colour VGA+ 80x25 worker # [ 0.090470] printk: legacy console [tty0] enabled worker # [ 0.132297] printk: legacy console [ttyS0] enabled worker # [ 0.322536] ACPI: Core revision 20250807 hub # [ 3.511612] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 worker # [ 0.324153] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.326945] APIC: Switch to symmetric I/O mode setup worker # [ 0.328713] x2apic enabled worker # [ 0.329969] APIC: Switched APIC routing to: physical x2apic worker # [ 0.332831] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.334658] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns worker # [ 0.337807] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010) worker # [ 0.339923] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.341006] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.342805] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 3.289392] systemd[1]: Reloading finished in 165 ms. worker # [ 0.343809] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.345806] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.347806] Transient Scheduler Attacks: Mitigation: Clear CPU buffers worker # [ 0.348805] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.349805] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.350805] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.351814] Spectre V2 : Enabling IBPB for BPF hub # [ 3.301668] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace... worker # [ 0.352807] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.353806] active return thunk: srso_alias_return_thunk hub # [ 3.308299] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace... worker # [ 0.355834] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 3.313775] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 0.357805] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 3.316289] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 0.359805] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 3.318316] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 0.361805] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.362805] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.363805] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 3.322378] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 0.364805] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.365805] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' worker # [ 0.367805] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' worker # [ 0.368806] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.370805] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 worker # [ 0.371805] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 worker # [ 0.372805] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.373806] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.374805] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 worker # [ 0.375805] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 worker # [ 0.377805] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. worker # [ 0.413686] Freeing SMP alternatives memory: 44K worker # [ 0.414807] pid_max: default: 32768 minimum: 301 worker # [ 0.415922] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.417930] landlock: Up and running. worker # [ 0.419805] Yama: becoming mindful. worker # [ 0.421017] LSM support for eBPF active worker # [ 0.421899] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.423851] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.427081] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.428399] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.428815] ... version: 2 worker # [ 0.429807] ... bit width: 48 worker # [ 0.430807] ... generic counters: 6 worker # [ 0.431806] ... generic bitmap: 000000000000003f worker # [ 0.432807] ... fixed-purpose counters: 0 worker # [ 0.433807] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.434807] ... value mask: 0000ffffffffffff worker # [ 0.435806] ... max period: 00007fffffffffff worker # [ 0.436806] ... global_ctrl mask: 000000000000003f worker # [ 0.437951] signal: max sigframe size: 3376 worker # [ 0.438960] rcu: Hierarchical SRCU implementation. worker # [ 0.439811] rcu: Max phase no-delay instances is 400. worker # [ 0.445460] smp: Bringing up secondary CPUs ... worker # [ 0.445822] smp: Brought up 1 node, 1 CPU worker # [ 0.446810] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) worker # [ 0.448026] Memory: 1969864K/2096600K available (17150K kernel code, 2721K rwdata, 13544K rodata, 3640K init, 3012K bss, 117324K reserved, 0K cma-reserved) worker # [ 0.449089] devtmpfs: initialized worker # [ 0.450017] x86/mm: Memory block size: 128MB worker # [ 0.451945] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.452844] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.453905] pinctrl core: initialized pinctrl subsystem worker # [ 0.455154] PM: RTC time: 13:40:37, date: 2026-08-01 worker # [ 0.458953] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.460320] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.460837] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.462113] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.462822] audit: initializing netlink subsys (disabled) worker # [ 0.464117] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.464120] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.464811] audit: type=2000 audit(1785591637.081:1): state=initialized audit_enabled=0 res=1 worker # [ 0.466810] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.466812] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.467807] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.468828] cpuidle: using governor menu worker # [ 0.472042] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.473108] PCI: Using configuration type 1 for base access worker # [ 0.473808] PCI: Using configuration type 1 for extended access worker # [ 0.475042] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.480102] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.480808] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.485807] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.486807] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.497176] ACPI: Added _OSI(Module Device) worker # [ 0.497808] ACPI: Added _OSI(Processor Device) worker # [ 0.502806] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.507885] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.512284] ACPI: Interpreter enabled worker # [ 0.512825] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.513808] ACPI: Using IOAPIC for interrupt routing worker # [ 0.514827] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.517806] PCI: Using E820 reservations for host bridge windows worker # [ 0.518959] ACPI: Enabled 2 GPEs in block 00 to 0F worker # [ 0.528473] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.528815] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.530287] acpiphp: Slot [3] registered worker # [ 0.530885] acpiphp: Slot [4] registered worker # [ 0.531933] acpiphp: Slot [5] registered worker # [ 0.532879] acpiphp: Slot [6] registered worker # [ 0.533871] acpiphp: Slot [7] registered worker # [ 0.534873] acpiphp: Slot [8] registered worker # [ 0.535885] acpiphp: Slot [9] registered worker # [ 0.536877] acpiphp: Slot [10] registered worker # [ 0.537875] acpiphp: Slot [11] registered worker # [ 0.538884] acpiphp: Slot [12] registered worker # [ 0.539871] acpiphp: Slot [13] registered worker # [ 0.540839] acpiphp: Slot [14] registered worker # [ 0.541839] acpiphp: Slot [15] registered worker # [ 0.542867] acpiphp: Slot [16] registered worker # [ 0.543840] acpiphp: Slot [17] registered worker # [ 0.544839] acpiphp: Slot [18] registered worker # [ 0.545842] acpiphp: Slot [19] registered worker # [ 0.546854] acpiphp: Slot [20] registered worker # [ 0.547840] acpiphp: Slot [21] registered worker # [ 0.548839] acpiphp: Slot [22] registered worker # [ 0.549839] acpiphp: Slot [23] registered worker # [ 0.550854] acpiphp: Slot [24] registered worker # [ 0.551841] acpiphp: Slot [25] registered worker # [ 0.552840] acpiphp: Slot [26] registered worker # [ 0.553860] acpiphp: Slot [27] registered worker # [ 0.554840] acpiphp: Slot [28] registered worker # [ 0.555869] acpiphp: Slot [29] registered worker # [ 0.556841] acpiphp: Slot [30] registered worker # [ 0.557853] acpiphp: Slot [31] registered worker # [ 0.558831] PCI host bridge to bus 0000:00 worker # [ 0.559814] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.560808] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.561808] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.562807] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] worker # [ 0.563808] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] worker # [ 0.564809] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.566138] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.567757] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.569759] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint worker # [ 0.572735] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f] worker # [ 0.573872] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk worker # [ 0.574808] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk worker # [ 0.575808] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk worker # [ 0.576808] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk worker # [ 0.578136] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.579890] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f] worker # [ 0.582167] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint worker # [ 0.583801] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI worker # [ 0.584822] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB worker # [ 0.586242] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.588908] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.589835] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.590861] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.592054] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.594001] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.596840] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] worker # [ 0.597822] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.598860] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.599822] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.603602] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.606839] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.607822] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.608861] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.611898] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.614848] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.615822] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.616867] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.619821] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.623848] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.624821] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.625861] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.629377] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.632848] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.633822] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.635004] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.638148] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.640846] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.641822] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.642861] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.645846] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.648821] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.650822] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.651861] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.652821] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.655790] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.658853] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.659861] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] worker # [ 0.662859] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.665859] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.666822] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.667860] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.671282] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.673845] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.674822] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.675892] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.684066] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.685036] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.686019] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.686996] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.687913] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 worker # [ 0.690063] iommu: Default domain type: Translated worker # [ 0.690818] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.692114] ACPI: bus type USB registered worker # [ 0.692869] usbcore: registered new interface driver usbfs worker # [ 0.693841] usbcore: registered new interface driver hub worker # [ 0.694821] usbcore: registered new device driver usb worker # [ 0.696768] NetLabel: Initializing worker # [ 0.697654] NetLabel: domain hash size = 128 worker # [ 0.698807] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.699853] NetLabel: unlabeled traffic allowed by default worker # [ 0.700824] PCI: Using ACPI for IRQ routing worker # [ 0.702461] pci 0000:00:02.0: vgaarb: setting as boot VGA device worker # [ 0.702802] pci 0000:00:02.0: vgaarb: bridge control possible worker # [ 0.702802] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.702809] vgaarb: loaded worker # [ 0.703957] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.704807] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.709901] clocksource: Switched to clocksource kvm-clock worker # [ 0.714109] VFS: Disk quotas dquot_6.6.0 worker # [ 0.715397] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.717692] pnp: PnP ACPI init worker # [ 0.719411] pnp: PnP ACPI: found 6 devices hub # [ 3.875263] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 0.727661] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.730321] clocksource: Switched to clocksource acpi_pm worker # [ 0.732062] NET: Registered PF_INET protocol family worker # [ 0.733995] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 3.886257] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.897278] systemd[1]: Mounting /sysroot/run... worker # [ 0.753029] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.755792] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.758144] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.760551] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 3.910277] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 0.762836] TCP: Hash tables configured (established 16384 bind 16384) worker # [ 0.764844] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) worker # [ 0.767117] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.769133] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.771317] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.773049] NET: Registered PF_XDP protocol family worker # [ 0.774576] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.776503] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 3.926400] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 0.778419] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.780511] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] worker # [ 0.782601] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] worker # [ 0.784869] pci 0000:00:01.0: PIIX3: Enabling Passive Release worker # [ 0.786631] pci 0000:00:00.0: Limiting direct PCI/PCI transfers worker # [ 0.790096] ACPI: \_SB_.LNKD: Enabled at IRQ 11 worker # [ 0.793545] PCI: CLS 0 bytes, default 64 worker # [ 0.795119] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns worker # [ 0.798148] Trying to unpack rootfs image as initramfs... hub # [ 4.207397] 9p: Installing v9fs 9p2000 file system support hub # [ 3.966649] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 3.976453] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.980063] systemd[1]: Mounted /sysroot/run. hub # [ 3.981687] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.984242] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 3.988939] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.846221] Initialise system trusted keyrings hub # [ 4.000945] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.850955] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 4.003684] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.007145] systemd[1]: Mounting /sysroot/nix/store... worker # [ 0.878294] Key type asymmetric registered hub # [ 4.029255] systemd[1]: Mounted /sysroot/nix/store. worker # [ 0.879643] Asymmetric key parser 'x509' registered hub # [ 4.031910] systemd[1]: Reached target Initrd File Systems. hub # [ 4.033723] systemd[1]: Starting Find NixOS closure... worker # [ 0.884828] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 4.038353] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 0.890838] io scheduler mq-deadline registered worker # [ 0.892276] io scheduler kyber registered worker # [ 0.896403] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.898673] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.907956] Linux agpgart interface v0.103 hub # [ 4.058824] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 0.909390] ACPI: bus type drm_connector registered worker # [ 0.913251] usbcore: registered new interface driver usbserial_generic worker # [ 0.915237] usbserial: USB Serial support registered for generic hub # [ 4.068673] systemd[1]: Finished Find NixOS closure. hub # [ 4.070784] systemd[1]: Reached target Initrd Default Target. worker # [ 0.921799] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 4.073468] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 0.921799] Please enable it if your BIOS has the CPPC option. worker # [ 0.925822] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.934937] drop_monitor: Initializing network drop monitor service worker # [ 0.936948] NET: Registered PF_INET6 protocol family hub # [ 4.088585] systemd[1]: Stopped target Initrd Default Target. hub # [ 4.090505] systemd[1]: Stopped target Basic System. worker # [ 0.942325] Segment Routing with IPv6 hub # [ 4.092331] systemd[1]: Stopped target Initrd Root Device. hub # [ 4.094266] systemd[1]: Stopped target Path Units. worker # [ 0.945797] In-situ OAM (IOAM) with IPv6 hub # [ 4.096331] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 0.949159] IPI shorthand broadcast: enabled hub # [ 4.099383] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 4.101381] systemd[1]: Stopped target Slice Units. hub # [ 4.102903] systemd[1]: Stopped target Socket Units. hub # [ 4.104865] systemd[1]: Stopped target System Initialization. hub # [ 4.107987] systemd[1]: Stopped target Swaps. hub # [ 4.109301] systemd[1]: Stopped target Timer Units. worker # [ 0.958209] sched_clock: Marking stable (710032410, 247724909)->(1166651158, -208893839) hub # [ 4.110668] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 4.112261] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.114354] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 0.967045] registered taskstats version 1 hub # [ 4.117241] systemd[1]: Stopped Find NixOS closure. worker # [ 0.968639] Loading compiled-in X.509 certificates hub # [ 4.118587] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 4.122101] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.123722] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 4.125635] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.128227] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 4.130135] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.131531] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.133756] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.136192] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.138737] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.141272] systemd[1]: Stopped target Local File Systems. worker # [ 0.991643] Demotion targets for Node 0: null hub # [ 4.144318] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 0.995952] Key type .fscrypt registered hub # [ 4.146205] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 0.997251] Key type fscrypt-provisioning registered hub # [ 4.149236] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 1.000894] ima: No TPM chip found, activating TPM-bypass! worker # [ 1.002570] ima: Allocated hash algorithm: sha1 hub # [ 4.155376] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.157335] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 1.007833] ima: No architecture policies found hub # [ 4.159219] systemd[1]: Stopped Virtual Console Setup. worker # [ 1.010791] PM: Magic number: 6:597:684 worker # [ 1.012133] mem full: hash matches worker # [ 1.016670] RAS: Correctable Errors collector initialized. hub # [ 4.172439] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.174947] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 1.028565] clk: Disabling unused clocks hub # [ 4.178819] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 4.180788] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 1.031789] PM: genpd: Disabling unused power domains hub # [ 4.182867] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.185415] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 4.188744] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 4.190784] systemd[1]: Closed udev Control Socket. hub # [ 4.194182] systemd[1]: Starting Cleanup udev Database... hub # [ 4.195651] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.197594] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.200261] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.202403] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.204339] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.206492] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 4.224903] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.226957] systemd[1]: Finished Cleanup udev Database. hub # [ 4.229361] systemd[1]: Reached target Switch Root. hub # [ 4.231849] systemd[1]: Starting NixOS Activation... worker # [ 1.177346] Freeing initrd memory: 28880K worker # [ 1.181309] Freeing unused decrypted memory: 2028K worker # [ 1.184717] Freeing unused kernel image (initmem) memory: 3640K worker # [ 1.186677] Write protecting the kernel read-only data: 32768k worker # [ 1.189562] Freeing unused kernel image (text/rodata gap) memory: 1280K worker # [ 1.192149] Freeing unused kernel image (rodata/data gap) memory: 792K worker # [ 1.245317] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.247311] Run /init as init process hub # [ 4.397115] initrd-nixos-activation-start[181]: booting system configuration /nix/store/v238fc49xbqqnla2zq3k3vnb2zsshslp-nixos-system-hub-test worker # [ 1.259025] systemd[1]: Inserted module 'autofs4' worker # [ 1.276207] fuse: init (API version 7.45) worker # [ 1.283806] ACPI: \_SB_.LNKC: Enabled at IRQ 10 worker # [ 1.293395] ACPI: \_SB_.LNKA: Enabled at IRQ 10 worker # [ 1.298180] ACPI: \_SB_.LNKB: Enabled at IRQ 11 hub # [ 4.464440] initrd-nixos-activation-start[181]: running activation script... worker # [ 1.340804] systemd[1]: Successfully made /usr/ read-only. worker # [ 1.680243] systemd[1]: systemd 261 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.702356] systemd[1]: Detected virtualization kvm. worker # [ 1.706440] systemd[1]: Detected architecture x86-64. worker # [ 1.710565] systemd[1]: Running in initrd. worker # [ 1.714931] systemd[1]: Initializing machine ID from random generator. worker # [ 1.720244] systemd[1]: Hostname set to . hub # [ 4.907380] initrd-nixos-activation-start[204]: setting up /etc... worker # [ 1.940862] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.001872] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 2.007436] systemd[1]: Created slice Slice /system/modprobe. worker # [ 2.009572] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 2.012072] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 2.014169] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 2.016196] systemd[1]: Reached target Path Units. worker # [ 2.017831] systemd[1]: Reached target Slice Units. worker # [ 2.019440] systemd[1]: Reached target Swaps. worker # [ 2.020980] systemd[1]: Reached target Timer Units. worker # [ 2.022830] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 2.025032] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 2.027105] systemd[1]: Listening on Journal Sockets. worker # [ 2.028928] systemd[1]: Listening on udev Control Socket. worker # [ 2.030822] systemd[1]: Listening on udev Kernel Socket. worker # [ 2.032561] systemd[1]: Reached target Socket Units. worker # [ 2.035421] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 2.041905] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 5.194372] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.197110] systemd[1]: Finished NixOS Activation. hub # [ 5.199980] systemd[1]: Starting Switch Root... worker # [ 2.051889] systemd[1]: Starting Load Kernel Module configfs... hub # [ 5.214105] systemd[1]: Switching root. worker # [ 2.065019] systemd[1]: Starting Journal Service... worker # [ 2.094965] netfs: FS-Cache loaded worker # [ 2.104955] 9pnet: Installing 9P2000 support worker # [ 2.107574] systemd[1]: Starting Load Kernel Modules... worker # [ 2.117914] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.128486] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.135587] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 2.148928] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.157655] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.171434] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.180257] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.184954] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.193426] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.197792] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 5.595443] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 2.203550] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.222008] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 2.244306] systemd[1]: Finished Load Kernel Modules. worker # [ 2.256548] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.274432] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.290170] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.308997] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.329901] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.336168] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.342880] systemd[1]: Reached target Local File Systems. worker # [ 2.103481] systemd-modules-load[68]: Inserted module 'dm_mod'[ 2.353380] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # hub # [ 5.752380] NET: Registered PF_VSOCK protocol family worker # [ 2.109475] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 2.111463] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.367010] systemd[1]: Started Journal Service. worker # [ 2.144514] systemd[1]: Starting Create System Files and Directories... worker # [ 2.177694] systemd[1]: Finished Create System Files and Directories. worker # [ 2.182325] systemd-udevd[76]: Using default interface naming scheme 'v261'. worker # [ 2.217117] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.267275] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.270779] systemd[1]: Reached target System Initialization. worker # [ 2.273213] systemd[1]: Reached target Basic System. hub # [ 6.140899] systemd[1]: systemd 261 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.157284] systemd[1]: Detected virtualization kvm. hub # [ 6.160552] systemd[1]: Detected architecture x86-64. hub # [ 6.163952] systemd[1]: Detected first boot. hub # [ 6.171037] systemd[1]: Initializing machine ID from random generator. worker # [ 2.804077] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.845890] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.847550] uhci_hcd 0000:00:01.2: UHCI Host Controller worker # [ 2.863549] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 worker # [ 2.875822] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.882325] uhci_hcd 0000:00:01.2: detected 2 ports worker # [ 2.889270] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.891644] SCSI subsystem initialized worker # [ 2.897928] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c140 worker # [ 2.905013] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # [ 2.910706] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.929176] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.950277] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.952536] usb usb1: Product: UHCI Host Controller worker # [ 2.711203] systemd[1]: Starting Virtual Console Setup... worker # [ 2.714544] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.970645] usb usb1: Manufacturer: Linux 6.18.39 uhci_hcd worker # [ 2.725815] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.729702] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.997991] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 3.001052] virtio_blk virtio5: [vdb] 2089352 512-byte logical blocks (1.07 GB/1020 MiB) worker # [ 3.009327] usb usb1: SerialNumber: 0000:00:01.2 worker # [ 2.763947] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.768534] systemd[1]: Finished Virtual Console Setup. worker # [ 3.025242] hub 1-0:1.0: USB hub found worker # [ 3.032192] hub 1-0:1.0: 2 ports detected hub # [ 6.426995] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 3.081565] scsi host0: ata_piix worker # [ 3.083345] scsi host1: ata_piix worker # [ 3.090022] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 0 worker # [ 2.846719] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.850215] systemd[1]: Reached target Initrd Root Device. worker # [ 2.852977] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 3.104691] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 0 worker # [ 2.865068] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.885582] systemd-fsck[117]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.894608] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.901110] systemd[1]: Mounting /sysroot... hub # [ 6.571069] systemd[1]: Applying preset policy. worker # [ 3.260085] ata2: found unknown device (class 0) worker # [ 3.262662] usb 1-1: new full-speed USB device number 2 using uhci_hcd worker # [ 3.267992] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.275269] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.333564] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.354234] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.375281] EXT4-fs (vda): mounted filesystem bf2ac7f2-d13b-47a7-b248-3b2aac9822a9 r/w with ordered data mode. Quota mode: none. worker # [ 3.133418] systemd[1]: Mounted /sysroot. worker # [ 3.135566] systemd[1]: Reached target Initrd Root File System. worker # [ 3.143137] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 3.147212] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.154209] systemd[1]: Mounting /sysroot/run... worker # [ 3.158633] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.176222] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 3.437361] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.192101] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 3.442856] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.446778] usb 1-1: Product: QEMU USB Tablet worker # [ 3.449049] usb 1-1: Manufacturer: QEMU worker # [ 3.452111] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 3.504257] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.505863] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 3.261215] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.521969] 9p: Installing v9fs 9p2000 file system support worker # [ 3.283106] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.287152] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.288635] systemd[1]: Mounted /sysroot/run. worker # [ 3.291377] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.292813] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.552022] usbcore: registered new interface driver usbhid worker # [ 3.308126] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.310992] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.316103] systemd[1]: Reloading... worker # [ 3.567250] usbhid: USB HID core driver worker # [ 3.591520] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 3.598853] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 worker # [ 3.435771] systemd[1]: Reloading finished in 119 ms. worker # [ 3.446675] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace... worker # [ 3.450757] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.454109] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.458515] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace... worker # [ 3.462803] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.466126] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.467952] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.472394] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 7.122154] systemd[1]: Populated /etc with preset unit settings. worker # [ 3.484412] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.486973] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 3.902548] systemd[1]: Mounting /sysroot/nix/store... worker # [ 3.953624] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.955796] systemd[1]: Reached target Initrd File Systems. worker # [ 3.960223] systemd[1]: Starting Find NixOS closure... worker # [ 3.966413] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 3.990578] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 3.996197] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 4.004200] systemd[1]: Finished Find NixOS closure. worker # [ 4.006450] systemd[1]: Reached target Initrd Default Target. worker # [ 4.009199] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 4.025844] systemd[1]: Stopped target Initrd Default Target. worker # [ 4.027871] systemd[1]: Stopped target Basic System. worker # [ 4.030267] systemd[1]: Stopped target Initrd Root Device. worker # [ 4.031761] systemd[1]: Stopped target Path Units. worker # [ 4.033288] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 4.035560] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 4.038393] systemd[1]: Stopped target Slice Units. worker # [ 4.040338] systemd[1]: Stopped target Socket Units. worker # [ 4.042243] systemd[1]: Stopped target System Initialization. worker # [ 4.045118] systemd[1]: Stopped target Swaps. worker # [ 4.046388] systemd[1]: Stopped target Timer Units. worker # [ 4.047813] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.049629] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 4.051535] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 4.054219] systemd[1]: Stopped Find NixOS closure. worker # [ 4.055571] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 4.058536] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 4.061222] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 4.062993] systemd[1]: Stopped Apply Kernel Variables. worker # [ 4.064454] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 4.067204] systemd[1]: Stopped Load Kernel Modules. worker # [ 4.068731] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 4.071177] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 7.716281] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 7.718799] systemd[1]: Stopped initrd-switch-root.service. worker # [ 4.073970] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 4.076842] systemd[1]: Stopped Create System Files and Directories. worker # [ 4.078518] systemd[1]: Stopped target Local File Systems. hub # [ 7.722819] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 4.081210] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 7.726006] systemd[1]: Created slice Slice /system/getty. worker # [ 4.083357] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 7.728073] systemd[1]: Created slice User and Session Slice. hub # [ 7.729638] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 4.086196] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 7.731789] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 4.087807] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 7.733679] systemd[1]: Expecting device /dev/hvc0... hub # [ 7.734982] systemd[1]: Expecting device /dev/ttyS0... worker # [ 4.090510] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 7.736338] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 4.093236] systemd[1]: Stopped Virtual Console Setup. hub # [ 7.737803] systemd[1]: Stopped target initrd-fs.target. hub # [ 7.739150] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 7.740603] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 7.742167] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 7.743834] systemd[1]: Reached target Path Units. hub # [ 7.745122] systemd[1]: Reached target Remote File Systems. hub # [ 7.746581] systemd[1]: Reached target Slice Units. worker # [ 4.101936] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 7.747904] systemd[1]: Reached target Swaps. worker # [ 4.108122] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 7.752580] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 7.758197] systemd[1]: Listening on Process Core Dump Socket. worker # [ 4.117156] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 7.762627] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 4.119546] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 4.122106] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 7.766897] systemd[1]: Listening on Factory Reset Management. hub # [ 7.768496] systemd[1]: Listening on Hostname Service Socket. worker # [ 4.124719] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 4.127373] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 7.774215] systemd[1]: Starting Journal Log Access Socket... worker # [ 4.130270] systemd[1]: Closed udev Control Socket. hub # [ 7.776503] systemd[1]: Listening on Journal Audit Socket. worker # [ 4.132316] systemd[1]: Starting Cleanup udev Database... worker # [ 4.133843] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 4.136237] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 7.781107] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 4.138261] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 7.783031] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 4.140847] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 7.785283] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 4.142706] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 7.787638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 4.145247] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 7.801898] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 7.803694] systemd[1]: Listening on udev Control Socket. hub # [ 7.805299] systemd[1]: Listening on udev Varlink Socket. worker # [ 4.161712] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 4.164529] systemd[1]: Finished Cleanup udev Database. hub # [ 7.810419] systemd[1]: Mounting Huge Pages File System... worker # [ 4.167110] systemd[1]: Reached target Switch Root. worker # [ 4.169147] systemd[1]: Starting NixOS Activation... hub # [ 7.814842] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 7.822863] systemd[1]: Mounting Kernel Debug File System... hub # [ 7.829963] systemd[1]: Mounting Kernel Trace File System... hub # [ 7.838965] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 7.842150] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 7.854059] systemd[1]: Starting Load Kernel Module configfs... hub # [ 7.857192] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 7.860103] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 7.863904] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 4.222332] initrd-nixos-activation-start[184]: booting system configuration /nix/store/rmmig3kvl5pf6y1myha3qnwr9vn6hn2j-nixos-system-worker-test worker # [ 4.242844] initrd-nixos-activation-start[184]: running activation script... hub # [ 7.907212] systemd[1]: Mounting FUSE Control File System... hub # [ 7.914365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 7.935913] systemd[1]: Starting Journal Service... hub # [ 7.947643] systemd[1]: Starting Load Kernel Modules... hub # [ 7.961575] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 7.973083] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 7.983230] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 8.004214] systemd[1]: Starting Coldplug All udev Devices... hub # [ 8.011858] systemd-journald[274]: Collecting audit messages is enabled. worker # [ 4.381072] initrd-nixos-activation-start[207]: setting up /etc... hub # [ 8.035002] systemd[1]: Listening on Journal Log Access Socket. hub # [ 8.040987] systemd[1]: Mounted Huge Pages File System. hub # [ 8.046589] loop: module loaded hub # [ 8.051497] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 8.062427] systemd[1]: Mounted Kernel Debug File System. hub # [ 8.071043] systemd[1]: Mounted Kernel Trace File System. hub # [ 8.079814] EXT4-fs (vda): re-mounted 97d7f728-df81-4677-bbf9-af476b75cc1c. hub # [ 8.085026] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 7.841718] systemd[1]: Queued start job for default target Multi-User System. hub # [ 7.846229] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 8.099130] systemd[1]: Started Journal Service. hub # [ 7.854478] systemd-modules-load[275]: Inserted module 'loop' worker # [ 4.456820] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.460128] systemd[1]: Finished NixOS Activation. worker # [ 4.462867] systemd[1]: Starting Switch Root... hub # [ 7.860464] systemd-modules-load[275]: Inserted module 'tls' hub # [ 7.865855] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 7.870558] systemd[1]: Finished Load Kernel Module configfs. worker # [ 4.477804] systemd[1]: Switching root. hub # [ 7.876412] systemd[1]: Mounted FUSE Control File System. hub # [ 7.880152] systemd[1]: Finished Load Kernel Modules. hub # [ 7.885238] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 7.903610] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 7.913379] systemd[1]: Mounting Kernel Configuration File System... hub # [ 7.916248] systemd-oomd[277]: No swap; memory pressure usage will be degraded hub # [ 7.923166] systemd[1]: Starting Firewall... hub # [ 7.930624] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 7.938099] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 7.951518] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 7.964510] systemd[1]: Starting Apply Kernel Variables... hub # [ 7.983262] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 7.988126] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 8.002325] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 4.852282] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 8.264250] systemd-journald[274]: Received client request to flush runtime journal. worker # [ 4.939298] NET: Registered PF_VSOCK protocol family hub # [ 8.231783] systemd[1]: Mounted Kernel Configuration File System. hub # [ 8.238575] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 8.241780] systemd[1]: Reached target First Boot Complete. hub # [ 8.246980] systemd[1]: Finished Apply Kernel Variables. hub # [ 8.252434] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 8.255258] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 8.257840] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 8.291509] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 8.295549] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 8.302113] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 8.376274] systemd[1]: Finished Coldplug All udev Devices. hub # [ 8.402532] systemd-udevd[318]: Using default interface naming scheme 'v261'. worker # [ 5.296625] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) worker # [ 5.313280] systemd[1]: Detected virtualization kvm. worker # [ 5.316545] systemd[1]: Detected architecture x86-64. worker # [ 5.319985] systemd[1]: Detected first boot. hub # [ 8.475436] systemd[1]: Mounting /run/wrappers... worker # [ 5.323886] systemd[1]: Initializing machine ID from random generator. hub # [ 8.520423] systemd[1]: Mounted /run/wrappers. hub # [ 8.523377] systemd[1]: Reached target Local File Systems. hub # [ 8.527581] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 8.533464] systemd[1]: Starting register-nix-paths.service... hub # [ 8.538865] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 8.542161] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 8.555221] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 8.568382] systemd[1]: Starting Create System Files and Directories... hub # [ 8.574281] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 8.646794] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 8.655492] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 5.565170] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 8.732812] systemd[1]: Finished Create System Files and Directories. hub # [ 8.744893] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 8.756846] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 5.683998] systemd[1]: Applying preset policy. hub # [ 8.840358] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 8.893762] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 8.904555] systemd[1]: Starting Update is Completed... hub # [ 8.961836] systemd[1]: Finished Update is Completed. worker # [ 5.822378] systemd[1]: Populated /etc with preset unit settings. worker # [ 5.929508] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.932110] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.936004] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.939255] systemd[1]: Created slice Slice /system/getty. worker # [ 5.941434] systemd[1]: Created slice User and Session Slice. worker # [ 5.943042] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 9.094413] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.945064] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.946944] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.948238] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.949575] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.951065] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.952409] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.953864] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.955390] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.957077] systemd[1]: Reached target Path Units. worker # [ 5.958386] systemd[1]: Reached target Remote File Systems. worker # [ 5.959851] systemd[1]: Reached target Slice Units. worker # [ 5.961121] systemd[1]: Reached target Swaps. worker # [ 5.963200] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.966028] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.968106] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.970470] systemd[1]: Listening on Factory Reset Management. worker # [ 5.972108] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.975342] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.977444] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.980485] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 5.982404] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.984370] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.986660] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 5.990534] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.992369] systemd[1]: Listening on udev Control Socket. worker # [ 5.993942] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.997331] systemd[1]: Mounting Huge Pages File System... worker # [ 6.003856] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 6.012094] systemd[1]: Mounting Kernel Debug File System... worker # [ 6.023215] systemd[1]: Mounting Kernel Trace File System... worker # [ 6.038863] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 6.049145] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 6.065868] systemd[1]: Starting Load Kernel Module configfs... worker # [ 6.068329] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 6.073461] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.076385] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.082846] systemd[1]: Mounting FUSE Control File System... worker # [ 6.087870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.104860] systemd[1]: Starting Journal Service... worker # [ 6.109866] systemd[1]: Starting Load Kernel Modules... worker # [ 6.116862] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 6.123856] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 9.275849] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 6.126837] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 9.283095] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 6.135938] systemd[1]: Starting Coldplug All udev Devices... worker # [ 6.144046] systemd[1]: Listening on Journal Log Access Socket. worker # [ 6.148260] systemd[1]: Mounted Huge Pages File System. worker # [ 6.150998] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 6.155005] systemd[1]: Mounted Kernel Debug File System. worker # [ 6.158017] systemd[1]: Mounted Kernel Trace File System. worker # [ 6.162895] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 6.166201] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 6.171504] systemd[1]: Finished Load Kernel Module configfs. worker # [ 6.175236] systemd[1]: Mounted FUSE Control File System. worker # [ 6.184858] systemd[1]: Mounting Kernel Configuration File System... hub # [ 9.345526] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 6.201521] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 6.217967] systemd-journald[277]: Collecting audit messages is enabled. worker # [ 6.228872] EXT4-fs (vda): re-mounted bf2ac7f2-d13b-47a7-b248-3b2aac9822a9. worker # [ 6.233502] systemd[1]: Mounted Kernel Configuration File System. worker # [ 6.238926] loop: module loaded worker # [ 6.247250] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 6.251268] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 6.255121] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 9.409413] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 6.265864] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 6.268817] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.275896] systemd[1]: Finished Load Kernel Modules. worker # [ 6.285858] systemd[1]: Starting Firewall... worker # [ 6.294865] systemd[1]: Starting Apply Kernel Variables... hub # [ 9.461652] (udev-worker)[406]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 9.466632] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line. hub # [ 9.474682] (udev-worker)[414]: Network interface NamePolicy= disabled on kernel command line. worker # [ 6.340984] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 6.351866] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 6.355160] systemd[1]: Started Journal Service. worker # [ 6.116218] systemd[1]: Queued start job for default target Multi-User System. worker # [ 6.118664] systemd[1]: Unnecessary job was removed for /dev/vdb. worker # [ 6.128825] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 6.139191] systemd-modules-load[278]: Inserted module 'loop' worker # [ 6.145773] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 6.156180] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 6.163361] systemd[1]: Reached target First Boot Complete. worker # [ 6.173340] systemd[1]: Finished Apply Kernel Variables. worker # [ 6.198645] systemd-oomd[280]: No swap; memory pressure usage will be degraded hub # [ 9.601446] systemd[1]: Finished register-nix-paths.service. hub # [ 9.605130] systemd[1]: Reached target System Initialization. worker # [ 6.209453] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 9.608119] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 9.611272] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 9.613724] systemd[1]: Reached target Timer Units. hub # [ 9.616820] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 6.467139] systemd-journald[277]: Received client request to flush runtime journal. hub # [ 9.618973] systemd[1]: Listening on Nix Daemon Socket. hub # [ 9.622656] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 9.624832] systemd[1]: Reached target Socket Units. hub # [ 9.627955] systemd[1]: Reached target Basic System. hub # [ 9.631099] systemd[1]: Started backdoor.service. hub # [ 9.639511] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 9.654711] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 9.667136] systemd[1]: Starting Post-Boot Actions... hub # [ 9.688897] systemd[1]: Started Reset console on configuration changes. hub # [ 9.718199] systemd[1]: Starting resolvconf update... hub # [ 9.744896] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 9.758956] systemd[1]: Finished Firewall. hub # connecting to host... hub # [ 9.794851] systemd[1]: Finished Post-Boot Actions. hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 7.38 seconds) hub: (finished: waiting for the VM to finish booting, in 7.38 seconds) hub # [ 9.825375] nsncd[504]: Aug 01 13:40:43.295 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.838849] systemd[1]: Starting D-Bus System Message Bus... hub # [ 9.843208] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 6.446404] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 9.845854] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 9.849296] systemd[1]: Reached target User and Group Name Lookups. worker # [ 6.454699] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 6.458910] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 6.465465] systemd-udevd[312]: Using default interface naming scheme 'v261'. worker # [ 6.467399] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 6.471253] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 9.875481] systemd[1]: Starting User Login Management... hub # [ 9.885663] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 10.048265] dbus-broker-launch[536]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 10.064312] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 10.067858] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 10.070497] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 10.073652] systemd[1]: Stopping User and Group Name Lookups... hub # [ 10.076330] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 6.686814] systemd[1]: Finished Coldplug All udev Devices. hub # [ 10.082985] dbus-broker-launch[536]: NSS returned no entry for 'systemd-timesync' hub # [ 10.086427] dbus-broker-launch[536]: Invalid user-name in /nix/store/11h1dp638p40ljsid8ffys4fyxhgq858-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 6.694087] systemd[1]: Mounting /run/wrappers... hub # [ 10.091678] systemd[1]: nscd.service: Deactivated successfully. hub # [ 10.095782] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 10.099477] systemd-logind[539]: New seat seat0. hub # [ 10.107200] systemd[1]: Started User Login Management. worker # [ 6.721775] systemd[1]: Mounted /run/wrappers. worker # [ 6.724226] systemd[1]: Reached target Local File Systems. hub # [ 10.124754] systemd[1]: Starting linger-users.service... worker # [ 6.729533] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 6.734696] systemd[1]: Starting register-nix-paths.service... hub # [ 10.132438] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 6.739563] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 10.139184] systemd[1]: Started D-Bus System Message Bus. worker # [ 6.741215] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 6.748279] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 6.757113] systemd[1]: Starting Create System Files and Directories... hub # [ 10.190391] dbus-broker-launch[536]: Ready hub # [ 10.448879] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.812853] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 6.820233] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 10.233106] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 10.234991] nsncd[593]: Aug 01 13:40:43.703 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 10.240920] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 10.243710] systemd[1]: Finished linger-users.service. hub # [ 10.247987] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 10.250629] systemd[1]: Reached target User and Group Name Lookups. hub # [ 10.268224] systemd[1]: Finished resolvconf update. worker # [ 6.873238] systemd[1]: Finished Create System Files and Directories. hub # [ 10.273192] systemd[1]: Reached target Preparation for Network. worker # [ 6.879395] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 10.280285] systemd[1]: Starting DHCP Client... worker # [ 6.885130] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 10.285255] systemd[1]: Starting Address configuration of eth1... hub # [ 10.297170] systemd[1]: Starting Extra networking commands.... hub # [ 10.309974] systemd[1]: Starting Tailscale node agent... hub # [ 10.567242] ACPI: button: Power Button [PWRF] hub # [ 10.593343] mousedev: PS/2 mouse device common for all mice worker # [ 6.962571] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 6.975130] systemd[1]: Finished Firewall. hub # [ 10.653686] rtc_cmos 00:05: RTC can wake from S4 worker # [ 7.023405] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.029134] systemd[1]: Starting Update is Completed... worker # [ 7.075123] systemd[1]: Finished Update is Completed. hub # [ 10.723581] Floppy drive(s): fd0 is 2.88M AMI BIOS hub # [ 10.481344] network-addresses-eth1-start[620]: adding address 192.168.1.1/24... done worker # [ 7.086284] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 10.490734] network-addresses-eth1-start[620]: adding address 2001:db8:1::1/64... done hub # [ 10.526288] systemd[1]: Finished Address configuration of eth1. hub # [ 10.779170] FDC 0 is a S82078B hub # [ 10.794989] parport_pc 00:03: reported by Plug and Play ACPI hub # [ 10.826652] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 10.851889] rtc_cmos 00:05: registered as rtc0 worker # [ 7.207858] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 7.212206] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 10.891176] rtc_cmos 00:05: setting system clock to 2026-08-01T13:40:43 UTC (1785591643) hub # [ 10.893444] systemd-journald[274]: Time jumped backwards, rotating. hub # [ 10.917531] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 7.290742] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. hub # [ 10.936241] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 10.949127] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 hub # [ 10.715499] systemd[1]: Finished Extra networking commands.. hub # [ 10.724668] dhcpcd[634]: dhcpcd-10.3.2 starting hub # [ 10.743724] systemd[1]: Reached target Network. hub # [ 10.751539] dhcpcd[694]: dev: loaded udev hub # [ 10.764715] systemd[1]: Starting Nginx Web Server... worker # [ 7.372852] (udev-worker)[357]: Network interface NamePolicy= disabled on kernel command line. hub # [ 10.773567] systemd[1]: Starting Permit User Sessions... worker # [ 7.380119] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 7.384674] (udev-worker)[363]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 10.785401] systemd[1]: Finished Permit User Sessions. worker # [ 7.390168] (udev-worker)[363]: Network interface NamePolicy= disabled on kernel command line. worker # [ 7.417207] systemd[1]: Finished register-nix-paths.service. worker # [ 7.422308] systemd[1]: Reached target System Initialization. worker # [ 7.423934] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 7.425927] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 7.428267] systemd[1]: Reached target Timer Units. worker # [ 7.432271] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 7.433994] systemd[1]: Listening on Nix Daemon Socket. worker # [ 7.436240] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 7.443175] systemd[1]: Listening on tribuchet-agent-1.socket. worker # [ 7.445235] systemd[1]: Listening on tribuchet-agent-2.socket. worker # [ 7.446846] systemd[1]: Listening on tribuchet-agent-3.socket. worker # [ 7.452082] systemd[1]: Listening on tribuchet-agent-4.socket. worker # [ 7.455460] systemd[1]: Reached target Socket Units. worker # [ 7.462463] systemd[1]: Reached target Basic System. worker # [ 7.464245] systemd[1]: Started backdoor.service. hub # [ 10.861246] tailscaled[622]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 7.465644] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 7.476912] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 7.478890] systemd[1]: Starting Post-Boot Actions... worker # [ 7.485518] systemd[1]: Started Reset console on configuration changes. worker # [ 7.494475] systemd[1]: Starting resolvconf update... hub # [ 10.892796] tailscaled[622]: logtail started worker # [ 7.502177] systemd[1]: Starting D-Bus System Message Bus... hub # [ 10.897545] tailscaled[622]: Program starting: v1.98.8, Go 1.26.5: []string{"/nix/store/ax6n9rcfhx3x787vvg7hfgmmvrl32d30-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} hub # [ 10.902902] tailscaled[622]: LogID: 2fab46a8d9f1842c58e75ecc80a0d3b8c6c4b4f518dbc35f823d827537172028 hub # [ 10.905201] tailscaled[622]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 10.907208] tailscaled[622]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 10.912186] tailscaled[622]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 7.555540] systemd[1]: Finished Post-Boot Actions. worker # connecting to host... hub # [ 10.970356] tailscaled[622]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:46806->[::1]:53: read: connection refused (in 21ms), trying bootstrap... worker # [ 7.600165] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 10.998339] tailscaled[622]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... worker # [ 7.601873] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.605249] systemd[1]: Reached target User and Group Name Lookups. hub # [ 11.003191] tailscaled[622]: bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.74.153:443: connect: network is unreachable hub # [ 11.009229] tailscaled[622]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ... worker # [ 7.613641] nsncd[502]: Aug 01 13:40:44.469 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.618506] systemd[1]: Starting User Login Management... hub # [ 11.013245] tailscaled[622]: bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f]:443: connect: network is unreachable hub # [ 11.018931] tailscaled[622]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ... worker # [ 7.625251] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 11.022279] tailscaled[622]: bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 144.202.67.195:443: connect: network is unreachable hub # [ 11.029821] tailscaled[622]: trying bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" ... hub # [ 11.032499] tailscaled[622]: bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:6001]:443: connect: network is unreachable hub # [ 11.039189] tailscaled[622]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... hub # [ 11.043245] tailscaled[622]: bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.134:443: connect: network is unreachable hub # [ 11.047991] tailscaled[622]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ... hub # [ 11.051230] tailscaled[622]: bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5801:10b7:5400:2ff:feaa:284c]:443: connect: network is unreachable worker # [ 7.659975] dbus-broker-launch[506]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 11.059205] tailscaled[622]: trying bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" ... hub # [ 11.061780] tailscaled[622]: bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 149.28.119.105:443: connect: network is unreachable hub # [ 11.066536] tailscaled[622]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ... worker # [ 7.671851] dbus-broker-launch[506]: NSS returned no entry for 'systemd-timesync' hub # [ 11.069644] tailscaled[622]: bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::f4]:443: connect: network is unreachable worker # [ 7.673783] dbus-broker-launch[506]: Invalid user-name in /nix/store/q2gwphismb9zq4n72i2sh692z34g16yf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" hub # [ 11.075867] tailscaled[622]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ... hub # [ 11.078565] tailscaled[622]: bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.94.167:443: connect: network is unreachable worker # [ 7.687117] systemd[1]: Started D-Bus System Message Bus. hub # [ 11.083762] tailscaled[622]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ... hub # [ 11.088782] tailscaled[622]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60]:443: connect: network is unreachable hub # [ 11.094363] tailscaled[622]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... hub # [ 11.096962] tailscaled[622]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable hub # [ 11.102404] tailscaled[622]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... hub # [ 11.106313] tailscaled[622]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2401:c080:1000:467f:5400:2ff:feee:22aa]:443: connect: network is unreachable hub # [ 11.111899] tailscaled[622]: logtail: upload: log upload of 472 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/c81d4a434812f7c87ecc736f3d8ba28061b54b1cb9a7510467b08f3ca7820372": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 7.721431] dbus-broker-launch[506]: Ready worker # [ 7.763208] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 7.772951] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 7.774773] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 7.779502] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 7.783600] systemd[1]: Stopping User and Group Name Lookups... hub # [ 10.987131] 8021q: 802.1Q VLAN Support v1.8 worker # [ 7.786263] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 7.791220] systemd[1]: nscd.service: Deactivated successfully. worker # [ 7.794705] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 7.798289] systemd[1]: nscd.service: Consumed 17ms CPU time over 328ms wall clock time, 6.9M memory peak, 5.5M read from disk. worker # [ 7.806501] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 10.987144] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 11.043300] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 7.815586] systemd-logind[528]: New seat seat0. worker # [ 7.817524] systemd[1]: Started User Login Management. worker # [ 7.823505] systemd[1]: Starting linger-users.service... hub # [ 11.222148] nginx-pre-start[705]: nginx: the configuration file /nix/store/4cl9z0nwpy8d7balh4lnzqlpz1zbx13c-nginx.conf syntax is ok hub # [ 11.225494] nginx-pre-start[705]: nginx: configuration file /nix/store/4cl9z0nwpy8d7balh4lnzqlpz1zbx13c-nginx.conf test is successful hub # [ 11.370669] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 11.377512] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 worker # [ 7.864604] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 11.264464] dhcpcd[694]: eth0: waiting for carrier hub # [ 11.266373] dhcpcd[694]: eth0: carrier acquired worker # [ 7.869141] systemd[1]: Finished linger-users.service. worker # [ 7.874540] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.876271] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.879691] systemd[1]: Reached target User and Group Name Lookups. hub # [ 11.281218] dhcpcd[694]: DUID 00:01:00:01:32:00:b3:dc:52:54:00:12:34:56 worker # [ 7.882407] nsncd[577]: Aug 01 13:40:44.747 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 11.283560] dhcpcd[694]: eth0: IAID 00:12:34:56 hub # [ 11.285188] dhcpcd[694]: eth0: adding address fe80::5054:ff:fe12:3456 hub # [ 11.416316] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 11.416441] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 7.898304] systemd[1]: Finished resolvconf update. worker # [ 7.901497] systemd[1]: Reached target Preparation for Network. worker # [ 7.908122] systemd[1]: Starting DHCP Client... worker # [ 7.912178] systemd[1]: Starting Address configuration of eth1... worker # [ 7.915252] systemd[1]: Starting Extra networking commands.... hub # [ 11.419625] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 11.419633] cfg80211: failed to load regulatory.db worker # [ 7.923317] systemd[1]: Starting Tailscale node agent... hub # [ 11.429635] Console: switching to colour dummy device 80x25 hub # [ 11.432106] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 11.375752] systemd-logind[539]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 11.432549] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 11.510030] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 11.394288] systemd-logind[539]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) hub # [ 11.645668] ppdev: user-space parallel port driver hub # [ 11.653672] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 11.653674] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 11.413305] systemd[1]: Started Getty on tty1. hub # [ 11.414715] systemd[1]: Reached target Login Prompts. hub # [ 11.420312] systemd[1]: Started Nginx Web Server. worker # [ 8.024122] network-addresses-eth1-start[605]: adding address 192.168.1.2/24... done hub # [ 11.669818] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic hub # [ 11.671155] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 8.042119] network-addresses-eth1-start[605]: adding address 2001:db8:1::2/64... done hub # [ 11.441479] dbus-broker-launch[536]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 8.065501] systemd[1]: Finished Address configuration of eth1. hub # [ 11.498229] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. hub # [ 11.503121] tailscaled[622]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 11.505135] tailscaled[622]: dns: using "openresolv" mode hub # [ 11.511920] systemd[1]: Starting Virtual Console Setup... hub # [ 11.513778] tailscaled[622]: dns: using dns.openresolvManager worker # [ 8.201415] dhcpcd[618]: dhcpcd-10.3.2 starting hub # [ 11.800044] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 8.213240] dhcpcd[674]: dev: loaded udev hub # [ 11.843358] Console: switching to colour frame buffer device 160x50 worker # [ 8.465361] 8021q: 802.1Q VLAN Support v1.8 hub # [ 11.865023] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 8.469784] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.228339] systemd[1]: Finished Extra networking commands.. worker # [ 8.231365] systemd[1]: Reached target Network. worker # [ 8.243116] systemd[1]: Starting Permit User Sessions... worker # [ 8.318577] systemd[1]: Finished Permit User Sessions. worker # [ 8.327339] tailscaled[607]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 8.332308] systemd[1]: Started Getty on tty1. worker # [ 8.339305] systemd[1]: Reached target Login Prompts. hub # [ 11.988609] kvm_amd: TSC scaling supported hub # [ 11.989591] kvm_amd: Nested Virtualization enabled hub # [ 11.991847] kvm_amd: Nested Paging enabled hub # [ 11.993262] kvm_amd: LBR virtualization supported hub # [ 11.994951] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 8.351284] tailscaled[607]: logtail started hub # [ 11.996488] kvm_amd: Virtual GIF supported hub # [ 11.997816] kvm_amd: Virtual NMI enabled worker # [ 8.355345] tailscaled[607]: Program starting: v1.98.8, Go 1.26.5: []string{"/nix/store/ax6n9rcfhx3x787vvg7hfgmmvrl32d30-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} worker # [ 8.361140] tailscaled[607]: LogID: 04d3cf91bed326fc44446c8317e1c0a998a3e9da677c20bc9a228f1c89bd14ce worker # [ 8.367137] tailscaled[607]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.369063] tailscaled[607]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 8.372445] tailscaled[607]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 8.386172] dbus-broker-launch[506]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 8.641625] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 8.395901] tailscaled[607]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:57976->[::1]:53: read: connection refused (in 26ms), trying bootstrap... worker # [ 8.652966] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.654500] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.410258] tailscaled[607]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ... worker # [ 8.412742] tailscaled[607]: bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 207.148.3.137:443: connect: network is unreachable worker # [ 8.417337] tailscaled[607]: trying bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" ... worker # [ 8.420730] tailscaled[607]: bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::ec1:e001]:443: connect: network is unreachable worker # [ 8.674072] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.676160] cfg80211: failed to load regulatory.db worker # [ 8.429825] tailscaled[607]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ... worker # [ 8.432271] tailscaled[607]: bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 178.62.44.132:443: connect: network is unreachable worker # [ 8.440549] tailscaled[607]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ... worker # [ 8.444167] tailscaled[607]: bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::29:9001]:443: connect: network is unreachable worker # [ 8.450218] tailscaled[607]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ... worker # [ 8.452711] tailscaled[607]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable worker # [ 8.457269] tailscaled[607]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ... worker # [ 8.462149] tailscaled[607]: bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:289:5400:3ff:fe8d:cb5e]:443: connect: network is unreachable worker # [ 8.469043] tailscaled[607]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ... worker # [ 8.471552] tailscaled[607]: bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 18.230.97.74:443: connect: network is unreachable worker # [ 8.476203] tailscaled[607]: trying bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" ... worker # [ 8.481165] tailscaled[607]: bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::44c]:443: connect: network is unreachable worker # [ 8.486084] tailscaled[607]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ... worker # [ 8.488492] tailscaled[607]: bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 207.148.3.137:443: connect: network is unreachable worker # [ 8.493115] tailscaled[607]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... hub # [ 12.140262] EDAC MC: Ver: 3.0.0 worker # [ 8.498328] tailscaled[607]: bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c]:443: connect: network is unreachable worker # [ 8.503853] tailscaled[607]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ... worker # [ 8.507214] tailscaled[607]: bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 206.189.16.32:443: connect: network is unreachable worker # [ 8.514778] tailscaled[607]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ... hub # [ 11.916187] systemd[1]: Started Tailscale node agent. worker # [ 8.517628] tailscaled[607]: bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:289:5400:3ff:fe8d:cb5e]:443: connect: network is unreachable hub # [ 11.919493] tailscaled[622]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 8.771990] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 8.528118] tailscaled[607]: logtail: upload: log upload of 471 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/002b7aa9e6ebd6e0ae305cb70e14cb99e7d0c484a852d894c56791b5da64ee76": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 8.543123] tailscaled[607]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.545111] tailscaled[607]: dns: using "openresolv" mode worker # [ 8.546485] tailscaled[607]: dns: using dns.openresolvManager hub # [ 12.193235] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.816504] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.577194] dhcpcd[674]: eth0: waiting for carrier worker # [ 8.579321] dhcpcd[674]: eth0: carrier acquired hub # [ 11.981970] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 8.588837] dhcpcd[674]: DUID 00:01:00:01:32:00:b3:dd:52:54:00:12:34:56 hub # [ 11.985965] systemd[1]: Stopped Virtual Console Setup. worker # [ 8.590559] dhcpcd[674]: eth0: IAID 00:12:34:56 worker # [ 8.592321] dhcpcd[674]: eth0: adding address fe80::5054:ff:fe12:3456 hub # [ 11.990085] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 8.852473] mousedev: PS/2 mouse device common for all mice hub # [ 12.007477] (udev-worker)[766]: Network interface NamePolicy= disabled on kernel command line. worker # [ 8.861967] ACPI: button: Power Button [PWRF] hub # [ 12.012703] systemd[1]: Starting Virtual Console Setup... worker # [ 8.880509] rtc_cmos 00:05: RTC can wake from S4 hub # [ 12.045121] tailscaled[622]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 12.047092] tailscaled[622]: dns: using "openresolv" mode worker # [ 8.913134] parport_pc 00:03: reported by Plug and Play ACPI hub # [ 12.065667] tailscaled[622]: dns: using dns.openresolvManager hub # [ 12.067428] tailscaled[622]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} hub # [ 12.079361] tailscaled[622]: magicsock: disco key = d:d20fd35d4161fc6d hub # [ 12.081784] tailscaled[622]: Creating WireGuard device... hub # [ 12.084944] tailscaled[622]: Bringing WireGuard device up... hub # [ 12.087514] tailscaled[622]: Bringing router up... hub # [ 12.088831] tailscaled[622]: router: using firewall mode pref worker # [ 8.943989] rtc_cmos 00:05: registered as rtc0 worker # [ 8.950040] Floppy drive(s): fd0 is 2.88M AMI BIOS hub # [ 12.104556] tailscaled[622]: external route: up worker # [ 8.707575] tailscaled[607]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 8.959555] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.713371] systemd[1]: Started Tailscale node agent. worker # [ 8.963806] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 12.113675] tailscaled[622]: router: portUpdate(port=41641, network=udp6) hub # [ 12.116544] dhcpcd[694]: eth0: soliciting a DHCP lease worker # [ 8.966935] rtc_cmos 00:05: setting system clock to 2026-08-01T13:40:45 UTC (1785591645) worker # [ 8.970662] systemd-journald[277]: Time jumped backwards, rotating. hub # [ 12.130115] tailscaled[622]: router: default choosing iptables worker # [ 8.987404] FDC 0 is a S82078B hub # [ 12.385576] NET: Registered PF_PACKET protocol family hub # [ 12.145670] dhcpcd[694]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 8.996480] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 12.148227] dhcpcd[694]: eth0: probing address 10.0.2.15/24 hub # [ 12.177666] tailscaled[622]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 12.183954] tailscaled[622]: Clearing router settings... worker # [ 8.786733] tailscaled[607]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 12.185976] tailscaled[622]: Starting network monitor... worker # [ 8.788950] tailscaled[607]: dns: using "openresolv" mode hub # [ 12.188187] tailscaled[622]: router: portUpdate(port=41641, network=udp4) worker # [ 8.791668] tailscaled[607]: dns: using dns.openresolvManager worker # [ 8.795477] tailscaled[607]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 8.798637] tailscaled[607]: magicsock: disco key = d:2bc73b55d419014e worker # [ 8.800467] tailscaled[607]: Creating WireGuard device... hub # [ 12.199562] tailscaled[622]: Engine created. worker # [ 8.802565] tailscaled[607]: Bringing WireGuard device up... worker # [ 8.805205] tailscaled[607]: Bringing router up... worker # [ 8.806482] tailscaled[607]: router: using firewall mode pref hub # [ 12.208737] tailscaled[622]: pm: migrating "_daemon" profile to new format worker # [ 8.811701] tailscaled[607]: router: portUpdate(port=41641, network=udp6) hub # [ 12.210889] tailscaled[622]: envknob: PORT="41641" worker # [ 8.817586] tailscaled[607]: external route: up hub # [ 12.216890] tailscaled[622]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 12.219979] tailscaled[622]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 12.225378] tailscaled[622]: got LocalBackend in 310ms hub # [ 12.227262] tailscaled[622]: Start hub # [ 12.228475] tailscaled[622]: ipnext: "conn25": skipping extension hub # [ 12.230103] tailscaled[622]: ipnext: active extensions: posture, clientupdate, relayserver, taildrop, conn25, portlist hub # [ 12.236150] tailscaled[622]: profile data directory: profile not found worker # [ 9.088808] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console hub # [ 12.239120] tailscaled[622]: Backend: logs: be:2fab46a8d9f1842c58e75ecc80a0d3b8c6c4b4f518dbc35f823d827537172028 fe: worker # [ 8.845190] tailscaled[607]: router: default choosing iptables hub # [ 12.242110] tailscaled[622]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 12.244618] tailscaled[622]: blockEngineUpdates(true) hub # [ 12.250426] tailscaled[622]: health(warnable=wantrunning-false): error: Tailscale is stopped. hub # [ 12.254350] tailscaled[622]: wgengine: Reconfig: configuring router hub # [ 12.256656] tailscaled[622]: wgengine: Reconfig: user dialer hub # [ 12.258378] tailscaled[622]: wgengine: Reconfig: configuring DNS hub # [ 12.260356] tailscaled[622]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 8.864353] tailscaled[607]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 12.262809] tailscaled[622]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 12.264810] tailscaled[622]: dns: OScfg: {} worker # [ 9.115558] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 worker # [ 8.872122] tailscaled[607]: Clearing router settings... worker # [ 8.873637] tailscaled[607]: Starting network monitor... worker # [ 8.874978] tailscaled[607]: Engine created. worker # [ 8.877110] tailscaled[607]: router: portUpdate(port=41641, network=udp4) worker # [ 8.886597] tailscaled[607]: pm: migrating "_daemon" profile to new format worker # [ 8.888296] tailscaled[607]: envknob: PORT="41641" worker # [ 8.889536] tailscaled[607]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.891978] tailscaled[607]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 8.900223] tailscaled[607]: got LocalBackend in 195ms worker # [ 8.902429] tailscaled[607]: Start worker # [ 8.903581] tailscaled[607]: ipnext: "conn25": skipping extension worker # [ 8.905408] tailscaled[607]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop worker # [ 8.911101] tailscaled[607]: profile data directory: profile not found worker # [ 8.912710] tailscaled[607]: Backend: logs: be:04d3cf91bed326fc44446c8317e1c0a998a3e9da677c20bc9a228f1c89bd14ce fe: worker # [ 8.915076] tailscaled[607]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 8.919201] tailscaled[607]: blockEngineUpdates(true) worker # [ 8.920511] tailscaled[607]: wgengine: Reconfig: configuring router worker # [ 8.922093] tailscaled[607]: wgengine: Reconfig: user dialer worker # [ 8.923482] tailscaled[607]: wgengine: Reconfig: configuring DNS worker # [ 8.924969] tailscaled[607]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 8.928324] tailscaled[607]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 8.930953] tailscaled[607]: dns: OScfg: {} worker # [ 8.933098] tailscaled[607]: health(warnable=wantrunning-false): error: Tailscale is stopped. hub # [ 12.423142] systemd-vconsole-setup[784]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 12.428322] systemd[1]: Finished Virtual Console Setup. worker # [ 9.222821] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 9.229623] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 worker # [ 9.253598] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 9.081767] systemd[1]: Starting Virtual Console Setup... worker # [ 9.254078] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 9.280535] Console: switching to colour dummy device 80x25 worker # [ 9.422405] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 9.422408] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 9.424871] ppdev: user-space parallel port driver worker # [ 9.112641] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 9.180833] (udev-worker)[367]: Network interface NamePolicy= disabled on kernel command line. worker # [ 9.430796] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic worker # [ 9.185426] systemd-logind[528]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 9.202256] systemd-logind[528]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 9.465819] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 9.246405] systemd-vconsole-setup[741]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.255315] systemd[1]: Finished Virtual Console Setup. worker # [ 9.281447] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.283924] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.286674] systemd[1]: Stopping Virtual Console Setup... worker # [ 9.290752] systemd[1]: Starting Virtual Console Setup... worker # [ 9.341978] systemd-vconsole-setup[747]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.583788] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 9.620309] Console: switching to colour frame buffer device 160x50 worker # [ 9.634631] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 9.357666] systemd-logind[528]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 9.398439] dhcpcd[674]: eth0: soliciting a DHCP lease worker # [ 9.405559] systemd[1]: Finished Virtual Console Setup. worker # [ 9.668424] NET: Registered PF_PACKET protocol family worker # [ 9.426523] dhcpcd[674]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 9.430185] dhcpcd[674]: eth0: probing address 10.0.2.15/24 worker # [ 9.466506] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.468786] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.470712] systemd[1]: Stopping Virtual Console Setup... worker # [ 9.486707] systemd[1]: Starting Virtual Console Setup... worker # [ 9.534921] systemd-vconsole-setup[760]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.540338] systemd[1]: Finished Virtual Console Setup. worker # [ 9.789762] kvm_amd: TSC scaling supported worker # [ 9.790519] kvm_amd: Nested Virtualization enabled worker # [ 9.791814] kvm_amd: Nested Paging enabled worker # [ 9.792578] kvm_amd: LBR virtualization supported worker # [ 9.793882] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 9.795015] kvm_amd: Virtual GIF supported worker # [ 9.796018] kvm_amd: Virtual NMI enabled worker # [ 9.828690] EDAC MC: Ver: 3.0.0 hub # [ 13.451963] dhcpcd[694]: eth0: soliciting an IPv6 router hub # [ 13.457874] dhcpcd[694]: eth0: Router Advertisement from fe80::2 hub # [ 13.462898] dhcpcd[694]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 13.468738] tailscaled[622]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 13.476364] dhcpcd[694]: eth0: adding route to fec0::/64 hub # [ 13.481598] dhcpcd[694]: eth0: adding default route via fe80::2 hub # [ 13.487394] tailscaled[622]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 13.501260] tailscaled[622]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] rebind-reason=[default-if-changed] hub # [ 13.522195] tailscaled[622]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 13.524979] tailscaled[622]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 13.526845] tailscaled[622]: dns: OScfg: {} hub # [ 13.578124] tailscaled[622]: wgengine: set DNS config again after major link change hub # [ 13.581201] tailscaled[622]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] hub # [ 13.585069] tailscaled[622]: magicsock: 0 active derp conns hub # [ 13.586474] tailscaled[622]: router: portUpdate(port=41641, network=udp6) hub # [ 13.588456] tailscaled[622]: router: portUpdate(port=41641, network=udp4) worker # [ 10.825839] dhcpcd[674]: eth0: soliciting an IPv6 router worker # [ 10.832186] dhcpcd[674]: eth0: Router Advertisement from fe80::2 worker # [ 10.836171] dhcpcd[674]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 10.842296] tailscaled[607]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 10.847572] tailscaled[607]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 10.852715] dhcpcd[674]: eth0: adding route to fec0::/64 worker # [ 10.856269] dhcpcd[674]: eth0: adding default route via fe80::2 worker # [ 10.903643] tailscaled[607]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed] worker # [ 10.928208] tailscaled[607]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 10.932428] tailscaled[607]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 10.935907] tailscaled[607]: dns: OScfg: {} worker # [ 10.953130] tailscaled[607]: wgengine: set DNS config again after major link change worker # [ 10.956117] tailscaled[607]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] worker # [ 10.958898] tailscaled[607]: magicsock: 0 active derp conns worker # [ 10.960425] tailscaled[607]: router: portUpdate(port=41641, network=udp6) worker # [ 10.962472] tailscaled[607]: router: portUpdate(port=41641, network=udp4) hub # [ 15.415449] tailscaled[622]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub # [ 15.476557] tailscaled[622]: monitor: RTM_NEWROUTE: src=, dst=fec0::7746:c6d5:ddc1:1e0b/128, gw=, outif=2, table=255 worker # [ 12.280975] tailscaled[607]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 12.661445] tailscaled[607]: monitor: RTM_NEWROUTE: src=, dst=fec0::18af:b413:cd41:cc0c/128, gw=, outif=2, table=255 hub # [ 16.909796] dhcpcd[694]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 16.917140] dhcpcd[694]: eth0: adding route to 10.0.2.0/24 hub # [ 16.924344] tailscaled[622]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 16.933958] tailscaled[622]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 16.939869] tailscaled[622]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 16.948472] dhcpcd[694]: eth0: adding default route via 10.0.2.2 hub # [ 16.955761] tailscaled[622]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 16.966961] tailscaled[622]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] rebind-reason=[ips-changed] hub # [ 17.001797] tailscaled[622]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 17.004163] tailscaled[622]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 17.005974] tailscaled[622]: dns: OScfg: {} hub # [ 17.131391] systemd[1]: Started DHCP Client. hub # [ 17.134791] systemd[1]: Reached target Network is Online. hub # [ 17.140106] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 17.142817] systemd[1]: Reached target Multi-User System. hub # [ 17.144766] systemd[1]: Startup finished in 988ms (kernel) + 4.453s (initrd) + 11.702s (userspace) = 17.144s. hub # [ 17.548226] headscale-start[914]: 2026-08-01T13:40:50Z WRN hub # [ 17.550231] headscale-start[914]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed. hub # [ 17.565164] headscale-start[914]: 2026-08-01T13:40:50Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 17.570242] headscale-start[914]: 2026-08-01T13:40:50Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 17.662885] headscale-start[914]: 2026-08-01T13:40:50Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 17.671912] headscale-start[914]: 2026-08-01T13:40:50Z INF starting headscale commit=v0.29.2 version=0.29.2 hub # [ 17.674359] headscale-start[914]: 2026-08-01T13:40:50Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 17.685358] headscale-start[914]: 2026-08-01T13:40:50Z INF stun server started at [::]:3478 hub # [ 17.688917] headscale-start[914]: 2026-08-01T13:40:50Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:144 > derp region: {RegionID:999 RegionCode: RegionName: Latitude:0 Longitude:0 Avoid:false NoMeasureNoHome:false Nodes:[0x30f6cd03a120]} hub # [ 17.693863] headscale-start[914]: 2026-08-01T13:40:50Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:145 > derp nodes[0]: &{Name:999 RegionID:999 HostName:hub CertName: IPv4: IPv6: STUNPort:3478 STUNOnly:false DERPPort:443 InsecureForTests:false STUNTestIP: CanPort80:false} hub # [ 17.702899] headscale-start[914]: 2026-08-01T13:40:50Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 17.714212] headscale-start[914]: 2026-08-01T13:40:50Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 17.718499] headscale-start[914]: 2026-08-01T13:40:50Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 17.720736] headscale-start[914]: 2026-08-01T13:40:50Z INF metrics server disabled (metrics_listen_addr is empty) worker # [ 14.413493] dhcpcd[674]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 14.419125] dhcpcd[674]: eth0: adding route to 10.0.2.0/24 worker # [ 14.428485] tailscaled[607]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 14.437573] dhcpcd[674]: eth0: adding default route via 10.0.2.2 worker # [ 14.441922] tailscaled[607]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 14.449943] tailscaled[607]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 14.457847] tailscaled[607]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 14.468455] tailscaled[607]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed] worker # [ 14.489352] tailscaled[607]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 14.491395] tailscaled[607]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 14.493953] tailscaled[607]: dns: OScfg: {} worker # [ 14.554860] systemd[1]: Started DHCP Client. worker # [ 14.558361] systemd[1]: Reached target Multi-User System. worker # [ 14.560125] systemd[1]: Startup finished in 1.003s (kernel) + 3.665s (initrd) + 9.889s (userspace) = 14.558s. hub # [ 18.105912] tailscaled[622]: wgengine: set DNS config again after major link change hub # [ 18.117337] tailscaled[622]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7746:c6d5:ddc1:1e0b/64] hub # [ 18.125258] tailscaled[622]: magicsock: 0 active derp conns hub # [ 18.130314] tailscaled[622]: router: portUpdate(port=41641, network=udp6) hub # [ 18.135113] tailscaled[622]: router: portUpdate(port=41641, network=udp4) hub # [ 18.137813] tailscaled[622]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 18.141101] tailscaled[622]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub: (finished: waiting for unit headscale, in 15.76 seconds) hub: waiting for TCP port 443 on localhost hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.07 seconds) hub: waiting for unit tailscaled hub: (finished: waiting for unit tailscaled, in 0.07 seconds) worker: waiting for unit tailscaled worker: waiting for the VM to finish booting worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 0.00 seconds) worker: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker: (finished: waiting for unit tailscaled, in 0.05 seconds) hub: must succeed: headscale users create test hub # [ 18.465600] headscale-start[914]: 2026-08-01T13:40:51Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 0.09 seconds) hub: must succeed: headscale preauthkeys -u 1 create --reusable hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.12 seconds) hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-H2x3Lwk3qDEt-rM1V-igxHhBvFR5-08Wy9ikTtVz64lAG7lp5-neo8gbtKtRI6JG085vCJO6EZ7sN --hostname hub hub # [ 18.661373] tailscaled[622]: localapi: [POST] /localapi/v0/check-prefs hub # [ 18.664460] tailscaled[622]: localapi: [POST] /localapi/v0/start hub # [ 18.665998] tailscaled[622]: Start hub # [ 18.667283] tailscaled[622]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="hub" update=check Persist=nil}, reason: [opts.UpdatePrefs] hub # [ 18.671582] tailscaled[622]: generating new machine key hub # [ 18.676955] tailscaled[622]: machine key written to store hub # [ 18.678634] tailscaled[622]: profile data directory: profile not found hub # [ 18.682446] tailscaled[622]: Backend: logs: be:2fab46a8d9f1842c58e75ecc80a0d3b8c6c4b4f518dbc35f823d827537172028 fe: hub # [ 18.691327] tailscaled[622]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 18.693529] tailscaled[622]: blockEngineUpdates(true) hub # [ 18.694836] tailscaled[622]: Reconfig(down): no changes made to Engine config hub # [ 18.698064] tailscaled[622]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 18.700212] tailscaled[622]: health(warnable=wantrunning-false): ok hub # [ 18.701752] tailscaled[622]: control: client.Shutdown ... hub # [ 18.703373] tailscaled[622]: control: mapRoutine: exiting hub # [ 18.705240] tailscaled[622]: control: authRoutine: exiting hub # [ 18.706649] tailscaled[622]: control: updateRoutine: exiting hub # [ 18.708729] tailscaled[622]: control: Client.Shutdown done. hub # [ 18.710400] tailscaled[622]: localapi: [POST] /localapi/v0/login-interactive hub # [ 18.713282] tailscaled[622]: StartLoginInteractiveAs("root"): url=false hub # [ 18.714916] tailscaled[622]: control: client.Login(2) hub # [ 18.717880] tailscaled[622]: control: LoginInteractive -> regen=true hub # [ 18.719607] tailscaled[622]: control: doLogin(regen=true, hasUrl=false) hub # [ 18.794990] tailscaled[622]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 18.812236] headscale-start[914]: 2026-08-01T13:40:51Z INF http request bytes=176 elapsed=3.282261 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:46286 status=200 hub # [ 18.820335] tailscaled[622]: control: control server key from https://hub: ts2021=[m5gH2], legacy= hub # [ 18.823119] tailscaled[622]: control: Generating a new nodekey. hub # [ 18.828094] tailscaled[622]: control: RegisterReq: onode= node=[oIaqQ] fup=false nks=false worker # [ 15.535200] tailscaled[607]: wgengine: set DNS config again after major link change worker # [ 15.545171] tailscaled[607]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::18af:b413:cd41:cc0c/64 fec0::5054:ff:fe12:3456/64] worker # [ 15.555276] tailscaled[607]: magicsock: 0 active derp conns worker # [ 15.564829] tailscaled[607]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 15.571841] tailscaled[607]: router: portUpdate(port=41641, network=udp6) worker # [ 15.577829] tailscaled[607]: router: portUpdate(port=41641, network=udp4) worker # [ 15.584794] tailscaled[607]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 19.696884] headscale-start[914]: 2026-08-01T13:40:52Z INF http request bytes=249 elapsed=846.161733 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:46292 status=200 hub # [ 19.709449] tailscaled[622]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 19.725231] tailscaled[622]: blockEngineUpdates(false) hub # [ 20.205965] headscale-start[914]: 2026-08-01T13:40:53Z INF http request bytes=0 elapsed=480.085318 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:46292 status=200 hub # [ 20.701266] headscale-start[914]: 2026-08-01T13:40:53Z INF node connected machine.key=[qpgUz] node.expired=false node.id=1 node.is_tagged=false node.key=[oIaqQ] node.name=hub node.online=true user.name=test hub # [ 20.711960] headscale-start[914]: 2026-08-01T13:40:53Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x30f6cce54a80 component=poll machine.key=[qpgUz] node.expired=false node.id=1 node.is_tagged=false node.key=[oIaqQ] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 20.771416] tailscaled[622]: health(warnable=not-in-map-poll): ok hub # [ 20.788680] tailscaled[622]: active login: test hub # [ 20.802050] tailscaled[622]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 20.805131] tailscaled[622]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 20.808791] tailscaled[622]: magicsock: SetPrivateKey called (init) hub # [ 20.811374] tailscaled[622]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers) hub # [ 20.813913] tailscaled[622]: wgengine: Reconfig: configuring router hub # [ 21.052306] tailscaled[622]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [16ms] (forced=false) hub # [ 21.055360] tailscaled[622]: magicsock: home is now derp-999 () hub # [ 21.059341] tailscaled[622]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 21.062352] tailscaled[622]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 21.064851] tailscaled[622]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 21.069760] tailscaled[622]: magicsock: endpoints changed: 127.0.0.1:41641 (stun), [2001:db8:1::1]:41641 (stun), 10.0.2.15:41641 (local), 192.168.1.1:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::7746:c6d5:ddc1:1e0b]:41641 (local) hub # [ 21.078373] tailscaled[622]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 21.093411] tailscaled[622]: magicsock: derp-999 connected; connGen=1 hub # [ 21.380053] tailscaled[622]: router: enabling connmark-based rp_filter workaround hub # [ 21.490963] tailscaled[622]: wgengine: Reconfig: user dialer hub # [ 21.493587] tailscaled[622]: tsdial: bart table size: 2 hub # [ 21.494933] tailscaled[622]: wgengine: Reconfig: configuring DNS hub # [ 21.496485] tailscaled[622]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1} hub # [ 21.552166] tailscaled[622]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa} hub # [ 21.554476] tailscaled[622]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 21.648221] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 21.651901] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 21.653842] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 21.656148] systemd[1]: Stopping User and Group Name Lookups... hub # [ 21.658268] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 21.661206] systemd[1]: nscd.service: Deactivated successfully. hub # [ 21.662965] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 21.677369] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 21.713771] tailscaled[622]: peerapi: serving on http://100.64.0.1:58436 hub # [ 21.716896] tailscaled[622]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 21.718736] tailscaled[622]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 21.725108] tailscaled[622]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 21.733698] tailscaled[622]: netmap: suggested exit node: () hub # [ 21.737464] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 21.739168] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 21.740805] systemd[1]: Reached target User and Group Name Lookups. hub # [ 21.745502] nsncd[1069]: Aug 01 13:40:54.598 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 21.749290] tailscaled[622]: writing netmap to disk cache hub # [ 21.754953] tailscaled[622]: health(warnable=no-derp-connection): ok hub # [ 21.756775] tailscaled[622]: health(warnable=no-derp-connection): ok hub # [ 21.760851] tailscaled[622]: health(warnable=warming-up): ok hub # [ 21.762280] tailscaled[622]: [RATELIMIT] format("health(warnable=%s): ok") hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-H2x3Lwk3qDEt-rM1V-igxHhBvFR5-08Wy9ikTtVz64lAG7lp5-neo8gbtKtRI6JG085vCJO6EZ7sN --hostname hub, in 3.17 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-H2x3Lwk3qDEt-rM1V-igxHhBvFR5-08Wy9ikTtVz64lAG7lp5-neo8gbtKtRI6JG085vCJO6EZ7sN --hostname tt-worker worker # [ 18.429373] tailscaled[607]: localapi: [POST] /localapi/v0/check-prefs worker # [ 18.431720] tailscaled[607]: localapi: [POST] /localapi/v0/start worker # [ 18.433664] tailscaled[607]: Start worker # [ 18.435446] tailscaled[607]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="tt-worker" update=check Persist=nil}, reason: [opts.UpdatePrefs] worker # [ 18.440063] tailscaled[607]: generating new machine key worker # [ 18.444825] tailscaled[607]: machine key written to store worker # [ 18.446372] tailscaled[607]: profile data directory: profile not found worker # [ 18.447950] tailscaled[607]: Backend: logs: be:04d3cf91bed326fc44446c8317e1c0a998a3e9da677c20bc9a228f1c89bd14ce fe: worker # [ 18.450307] tailscaled[607]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 18.453830] tailscaled[607]: blockEngineUpdates(true) worker # [ 18.455235] tailscaled[607]: Reconfig(down): no changes made to Engine config worker # [ 18.458106] tailscaled[607]: control: client.Shutdown ... worker # [ 18.459501] tailscaled[607]: control: mapRoutine: exiting worker # [ 18.460860] tailscaled[607]: control: authRoutine: exiting worker # [ 18.462266] tailscaled[607]: control: updateRoutine: exiting worker # [ 18.463667] tailscaled[607]: control: Client.Shutdown done. worker # [ 18.465230] tailscaled[607]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 18.467639] tailscaled[607]: health(warnable=wantrunning-false): ok worker # [ 18.470209] tailscaled[607]: localapi: [POST] /localapi/v0/login-interactive worker # [ 18.472324] tailscaled[607]: StartLoginInteractiveAs("root"): url=false worker # [ 18.474208] tailscaled[607]: control: client.Login(2) worker # [ 18.477254] tailscaled[607]: control: LoginInteractive -> regen=true worker # [ 18.479217] tailscaled[607]: control: doLogin(regen=true, hasUrl=false) worker # [ 18.506042] tailscaled[607]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 18.515098] tailscaled[607]: control: control server key from https://hub: ts2021=[m5gH2], legacy= worker # [ 18.517231] tailscaled[607]: control: Generating a new nodekey. worker # [ 18.519594] tailscaled[607]: control: RegisterReq: onode= node=[vKnlx] fup=false nks=false hub # [ 21.912521] headscale-start[914]: 2026-08-01T13:40:54Z INF http request bytes=176 elapsed=0.228521 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:46310 status=200 hub # [ 22.205546] headscale-start[914]: 2026-08-01T13:40:55Z INF http request bytes=0 elapsed=474.971819 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:46292 status=200 hub # [ 22.485596] tailscaled[622]: netmap: suggested exit node: () hub # [ 22.706231] headscale-start[914]: 2026-08-01T13:40:55Z INF http request bytes=249 elapsed=769.155577 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:46322 status=200 worker # [ 19.320282] tailscaled[607]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 19.334217] tailscaled[607]: blockEngineUpdates(false) hub # [ 23.208994] headscale-start[914]: 2026-08-01T13:40:56Z INF http request bytes=0 elapsed=476.107438 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:46322 status=200 hub # [ 23.288248] tailscaled[622]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 23.305415] tailscaled[622]: netmap: suggested exit node: () hub # [ 23.318372] tailscaled[622]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) hub # [ 23.323445] tailscaled[622]: wgengine: Reconfig: configuring router hub # [ 23.332778] tailscaled[622]: wgengine: Reconfig: user dialer hub # [ 23.335450] tailscaled[622]: tsdial: bart table size: 4 hub # [ 23.338321] tailscaled[622]: wgengine: Reconfig: configuring DNS hub # [ 23.339848] tailscaled[622]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} hub # [ 23.397785] tailscaled[622]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} hub # [ 23.400368] tailscaled[622]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 23.458395] tailscaled[622]: netmap: suggested exit node: () hub # [ 23.706260] headscale-start[914]: 2026-08-01T13:40:56Z INF node connected machine.key=[zXXc2] node.expired=false node.id=2 node.is_tagged=false node.key=[vKnlx] node.name=tt-worker node.online=true user.name=test hub # [ 23.717507] headscale-start[914]: 2026-08-01T13:40:56Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x30f6cce1fb90 component=poll machine.key=[zXXc2] node.expired=false node.id=2 node.is_tagged=false node.key=[vKnlx] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test worker # [ 20.351983] tailscaled[607]: health(warnable=not-in-map-poll): ok worker # [ 20.378257] tailscaled[607]: active login: test worker # [ 20.395865] tailscaled[607]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 20.400626] tailscaled[607]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 20.408201] tailscaled[607]: magicsock: SetPrivateKey called (init) worker # [ 20.411298] tailscaled[607]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) worker # [ 20.415577] tailscaled[607]: wgengine: Reconfig: configuring router worker # [ 20.542452] tailscaled[607]: router: enabling connmark-based rp_filter workaround worker # [ 20.567242] tailscaled[607]: wgengine: Reconfig: user dialer worker # [ 20.569113] tailscaled[607]: tsdial: bart table size: 4 worker # [ 20.570771] tailscaled[607]: wgengine: Reconfig: configuring DNS worker # [ 20.572586] tailscaled[607]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} worker # [ 20.590977] tailscaled[607]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} worker # [ 20.593667] tailscaled[607]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 20.640944] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 20.645432] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 20.647879] tailscaled[607]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [1ms] (forced=false) worker # [ 20.652228] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 20.653983] tailscaled[607]: magicsock: home is now derp-999 () worker # [ 20.657293] systemd[1]: Stopping User and Group Name Lookups... worker # [ 20.659799] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 20.661625] systemd[1]: nscd.service: Deactivated successfully. worker # [ 20.665220] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 20.670296] tailscaled[607]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 20.672586] tailscaled[607]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 20.677208] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 24.076656] tailscaled[622]: netmap: suggested exit node: () hub # [ 24.078582] tailscaled[622]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)") worker # [ 20.679117] tailscaled[607]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::18af:b413:cd41:cc0c]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local) worker # [ 20.683359] tailscaled[607]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 20.699929] tailscaled[607]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 20.711121] tailscaled[607]: magicsock: derp-999 connected; connGen=1 worker # [ 20.720706] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 20.722371] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 20.724760] systemd[1]: Reached target User and Group Name Lookups. worker # [ 20.727473] nsncd[955]: Aug 01 13:40:57.507 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 20.732310] tailscaled[607]: peerapi: serving on http://100.64.0.2:46590 worker # [ 20.733949] tailscaled[607]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 20.736507] tailscaled[607]: netmap: suggested exit node: () worker # [ 20.741705] tailscaled[607]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 20.746483] tailscaled[607]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 20.750119] tailscaled[607]: writing netmap to disk cache worker # [ 20.753720] tailscaled[607]: health(warnable=no-derp-connection): ok worker # [ 20.755684] tailscaled[607]: health(warnable=no-derp-connection): ok worker # [ 20.760116] tailscaled[607]: health(warnable=no-derp-connection): ok worker # [ 20.761721] tailscaled[607]: [RATELIMIT] format("health(warnable=%s): ok") worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-H2x3Lwk3qDEt-rM1V-igxHhBvFR5-08Wy9ikTtVz64lAG7lp5-neo8gbtKtRI6JG085vCJO6EZ7sN --hostname tt-worker, in 2.40 seconds) worker: waiting for success: tailscale ping hub worker # [ 20.794854] tailscaled[607]: localapi: [POST] /localapi/v0/ping worker # [ 20.796397] tailscaled[607]: ping(100.64.0.1): sending disco ping to [oIaqQ] hub ... worker # [ 20.799469] tailscaled[607]: magicsock: disco: node [oIaqQ] d:d20fd35d4161fc6d now using 192.168.1.1:41641 mtu=1360 tx=127dd6569838 worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds) hub: must succeed: tailscale ip -4 hub # [ 24.217914] headscale-start[914]: 2026-08-01T13:40:57Z INF http request bytes=0 elapsed=68.048034 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:46322 status=200 hub: (finished: must succeed: tailscale ip -4, in 0.09 seconds) worker: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml worker: (finished: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml, in 0.03 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 24.359968] systemd[1]: Starting tribuchet-hub.socket... hub # [ 24.369784] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 24.375379] systemd[1]: Starting tribuchet-hub.service... worker # [ 21.014965] tailscaled[607]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 24.467526] tribuchet[1111]: 2026-08-01T13:40:57.320690Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 24.472716] tribuchet[1111]: 2026-08-01T13:40:57.328128Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers hub # [ 24.477582] tribuchet[1111]: 2026-08-01T13:40:57.332802Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 24.486995] tribuchet[1111]: 2026-08-01T13:40:57.342395Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 24.491882] systemd[1]: Started tribuchet-hub.service. hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.18 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 21.144953] systemd[1]: Starting tribuchet-worker.service... worker # [ 21.212114] tribuchet[994]: 2026-08-01T13:40:57.992467Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", 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: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock", "/run/tribuchet/agents/3.sock", "/run/tribuchet/agents/4.sock"], spawn_agents: 0, agent_uid_base: None } worker # [ 21.231171] tribuchet[994]: 2026-08-01T13:40:58.011877Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/48czgycdvysxqlbgi6rgvx9cl4kl8mml-busybox-1.37.0/bin/busybox") worker # [ 21.240854] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.14 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' worker # [ 21.249248] systemd[1]: Started tribuchet-agent-1.service. worker # [ 21.293924] n2ljflpv8171mjajm4kppbl399w40gch-tribuchet-agent-1[997]: 2026-08-01T13:40:58.074335Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 21.300363] n2ljflpv8171mjajm4kppbl399w40gch-tribuchet-agent-1[997]: 2026-08-01T13:40:58.079737Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 21.305787] n2ljflpv8171mjajm4kppbl399w40gch-tribuchet-agent-1[997]: 2026-08-01T13:40:58.079776Z INFO tribuchet::worker::agent: agent listening uid=995 hub # [ 24.710582] headscale-start[914]: 2026-08-01T13:40:57Z INF http request bytes=0 elapsed=480.290372 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:46322 status=200 worker # [ 21.314992] systemd[1]: Started tribuchet-agent-2.service. worker # [ 21.339338] zy3kjai3k22gikd7lm39mjaf53v48blr-tribuchet-agent-2[1003]: 2026-08-01T13:40:58.119679Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536 worker # [ 21.345258] zy3kjai3k22gikd7lm39mjaf53v48blr-tribuchet-agent-2[1003]: 2026-08-01T13:40:58.119717Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 21.349656] zy3kjai3k22gikd7lm39mjaf53v48blr-tribuchet-agent-2[1003]: 2026-08-01T13:40:58.119749Z INFO tribuchet::worker::agent: agent listening uid=994 worker # [ 21.358452] systemd[1]: Started tribuchet-agent-3.service. worker # [ 21.381259] s3cl0154yidqj0638hd948j6jnh0dajr-tribuchet-agent-3[1008]: 2026-08-01T13:40:58.161682Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325531136 uid_count=65536 worker # [ 21.386568] s3cl0154yidqj0638hd948j6jnh0dajr-tribuchet-agent-3[1008]: 2026-08-01T13:40:58.166990Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 21.391883] s3cl0154yidqj0638hd948j6jnh0dajr-tribuchet-agent-3[1008]: 2026-08-01T13:40:58.167028Z INFO tribuchet::worker::agent: agent listening uid=993 worker # [ 21.400409] systemd[1]: Started tribuchet-agent-4.service. worker # [ 21.423269] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1013]: 2026-08-01T13:40:58.203705Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325596672 uid_count=65536 worker # [ 21.428622] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1013]: 2026-08-01T13:40:58.209037Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 21.434425] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1013]: 2026-08-01T13:40:58.209076Z INFO tribuchet::worker::agent: agent listening uid=992 hub # [ 24.855240] tailscaled[622]: magicsock: disco: node [vKnlx] d:2bc73b55d419014e now using [2001:db8:1::2]:41641 mtu=1360 tx=55e582ef8a10 worker # [ 21.494056] tailscaled[607]: [RATELIMIT] format("control: [v\x00JSON]%d%s") worker # [ 21.497932] tailscaled[607]: netmap: suggested exit node: () worker # [ 21.501598] tailscaled[607]: netmap: suggested exit node: () hub # [ 24.910652] tribuchet[1111]: 2026-08-01T13:40:57.766069Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }] worker # [ 21.545578] tribuchet[994]: 2026-08-01T13:40:58.326185Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] hub # [ 25.215952] headscale-start[914]: 2026-08-01T13:40:58Z INF http request bytes=0 elapsed=497.807124 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:46322 status=200 worker # [ 22.285158] tailscaled[607]: netmap: suggested exit node: () hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.15 seconds) subtest: a build dispatches over the tailnet hub: must succeed: echo tailscale-auth-payload > /root/payload hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.02 seconds) hub: must succeed: nix-store --add /root/payload hub: (finished: must succeed: nix-store --add /root/payload, in 0.13 seconds) hub: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/dddwfz7nph37q3cjky9lhpy9kb90rrrx-bash-interactive-5.3p15"; unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload"; in derivation { name = "tt-tailscale"; system = "x86_64-linux"; builder = bash + "/bin/bash"; args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ]; } EOF hub: (finished: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/dddwfz7nph37q3cjky9lhpy9kb90rrrx-bash-interactive-5.3p15"; unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload"; in derivation { name = "tt-tailscale"; system = "x86_64-linux"; builder = bash + "/bin/bash"; args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ]; } EOF, in 0.03 seconds) hub: must succeed: nix-build /root/test.nix --no-out-link hub # this derivation will be built: hub # /nix/store/ram7vwkcrvkgfhwdk4y68xb79mzd1xmq-tt-tailscale.drv hub # building '/nix/store/ram7vwkcrvkgfhwdk4y68xb79mzd1xmq-tt-tailscale.drv'... hub # [ 26.278584] tribuchet[1111]: 2026-08-01T13:40:59.133633Z INFO tribuchet::hub::submit: queueing build id="fa44275c3014c6e1e541fc92e8dfbe42" system="x86_64-linux" hub # [ 26.282967] tribuchet[1111]: 2026-08-01T13:40:59.133716Z INFO tribuchet::hub: dispatching build id="fa44275c3014c6e1e541fc92e8dfbe42" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 22.896729] tribuchet[994]: 2026-08-01T13:40:59.674949Z INFO tribuchet::worker: build assigned id="fa44275c3014c6e1e541fc92e8dfbe42" worker # [ 22.914716] systemd[1]: Started Nix Daemon. worker # [ 22.982229] nix-daemon[1018]: accepted connection from pid 994, user tribuchet (trusted) hub # [ 26.391235] tribuchet[1111]: 2026-08-01T13:40:59.246458Z INFO tribuchet::hub::relay: input path negotiation done id="fa44275c3014c6e1e541fc92e8dfbe42" total=8 missing=1 hub # [ 26.403233] systemd[1]: Started Nix Daemon. hub # [ 26.516137] nix-daemon[1148]: accepted connection from pid 1111, user root (trusted) worker # [ 23.188437] tribuchet[994]: 2026-08-01T13:40:59.968496Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="fa44275c3014c6e1e541fc92e8dfbe42" fixed_output=false network=false net_isolation=false worker # [ 23.228924] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1013]: 2026-08-01T13:41:00.007051Z INFO tribuchet::worker::agent: builder started id="fa44275c3014c6e1e541fc92e8dfbe42" pid=1026 worker # [ 23.238954] tribuchet[994]: 2026-08-01T13:41:00.007158Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="fa44275c3014c6e1e541fc92e8dfbe42" pid=1026 agent=/run/tribuchet/agents/4.sock scratch=/var/lib/tribuchet-agent-4/fa44275c3014c6e1e541fc92e8dfbe42/build worker # [ 23.259334] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1013]: 2026-08-01T13:41:00.040037Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 23.427844] tribuchet[994]: 2026-08-01T13:41:00.208054Z INFO tribuchet::worker::build::agent_exec: builder finished id="fa44275c3014c6e1e541fc92e8dfbe42" exit_code=0 aborted=None worker # [ 23.460887] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1013]: 2026-08-01T13:41:00.241354Z INFO tribuchet::worker::agent: cleanup done id="fa44275c3014c6e1e541fc92e8dfbe42" worker # [ 23.479799] systemd[1]: tribuchet-agent-4.service: Deactivated successfully. worker # [ 23.751428] tribuchet[994]: 2026-08-01T13:41:00.529961Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="fa44275c3014c6e1e541fc92e8dfbe42" worker # [ 23.770624] tribuchet[994]: 2026-08-01T13:41:00.550574Z INFO tribuchet::worker::resume: build result acknowledged id="fa44275c3014c6e1e541fc92e8dfbe42" hub # [ 27.200438] tailscaled[622]: magicsock: disco: node [vKnlx] d:2bc73b55d419014e now using 192.168.1.2:41641 mtu=1360 tx=ab8c00b3d527 hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 1.24 seconds) hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/9qvl9jmir81qmjij0p48h26vmh4cnwws-tt-tailscale hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/9qvl9jmir81qmjij0p48h26vmh4cnwws-tt-tailscale, in 0.03 seconds) hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build' hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.03 seconds) worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished' worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.04 seconds) (finished: subtest: a build dispatches over the tailnet, in 1.52 seconds) subtest: a non-tailnet peer is rejected worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.02 seconds) worker: must succeed: systemctl restart tribuchet-worker worker # [ 23.948243] systemd[1]: Stopping tribuchet-worker.service... worker # [ 23.950462] tribuchet[994]: 2026-08-01T13:41:00.727763Z INFO tribuchet::worker: handover requested; exiting worker # [ 23.956060] systemd[1]: tribuchet-worker.service: Deactivated successfully. hub # [ 27.354781] tribuchet[1111]: 2026-08-01T13:41:00.209865Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 23.959573] systemd[1]: Stopped tribuchet-worker.service. worker # [ 23.962100] systemd[1]: tribuchet-worker.service: Consumed 61ms CPU time over 2.813s wall clock time, 20M memory peak, 17.2M read from disk, 4K written to disk, 3K incoming IP traffic, 2.1K outgoing IP traffic. worker # [ 23.972783] systemd[1]: Starting tribuchet-worker.service... worker # [ 23.994337] tribuchet[1052]: 2026-08-01T13:41:00.773873Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", 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: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock", "/run/tribuchet/agents/3.sock", "/run/tribuchet/agents/4.sock"], spawn_agents: 0, agent_uid_base: None } worker # [ 24.010511] tribuchet[1052]: 2026-08-01T13:41:00.774308Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/48czgycdvysxqlbgi6rgvx9cl4kl8mml-busybox-1.37.0/bin/busybox") worker # [ 24.016404] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.09 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' worker # [ 24.024252] systemd[1]: Started tribuchet-agent-4.service. worker # [ 24.045238] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1058]: 2026-08-01T13:41:00.825661Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325596672 uid_count=65536 worker # [ 24.050569] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1058]: 2026-08-01T13:41:00.831067Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 24.055261] cgwiahr6mvsyjz52jr2j7prvzzpz1k7d-tribuchet-agent-4[1058]: 2026-08-01T13:41:00.831105Z INFO tribuchet::worker::agent: agent listening uid=992 hub # [ 27.832445] tribuchet[1111]: 2026-08-01T13:41:00.687499Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:58834 worker # [ 24.448652] tribuchet[1052]: 2026-08-01T13:41:01.228246Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 24.461369] tribuchet[1052]: 2026-08-01T13:41:01.228335Z INFO tribuchet::worker: reconnecting to hub in 1s hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.14 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.25 seconds) (finished: run the VM test script, in 29.67 seconds) test script finished in 29.76s cleanup kill QemuMachine (pid 47) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/rgnappqqc5vbq60gza5fflyk84sylwl6-python3-3.14.6/bin/python3.14) kill QemuMachine (pid 48) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/rgnappqqc5vbq60gza5fflyk84sylwl6-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.40 seconds) 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