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: QEMU running (pid 48) hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.WVrHTlICWa', 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: c4057e23-0f6a-46ac-9e1e-fc2da1680a28 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.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 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/lbcz8i8z8byzw30pfqxnlddykhf423jk-nixos-system-hub-test/init regInfo=/nix/store/ars76gx14vnprghnr6ny8ih69s6amfzj-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.000001] kvm-clock: using sched offset of 495808790 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000005] tsc: Detected 2400.018 MHz processor hub # [ 0.000812] last_pfn = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000849] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000852] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002772] found SMP MP-table at [mem 0x000f5470-0x000f547f] hub # [ 0.002783] Using GB pages for direct mapping hub # [ 0.002840] RAMDISK: [mem 0x7e302000-0x7ffcffff] hub # [ 0.002848] ACPI: Early table checksum verification disabled hub # [ 0.002852] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) hub # [ 0.002855] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002859] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002867] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002869] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002870] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002872] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002873] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002875] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] hub # [ 0.002876] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] hub # [ 0.002876] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002877] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] hub # [ 0.002877] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] hub # [ 0.002878] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] hub # [ 0.003358] No NUMA configuration found hub # [ 0.003360] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] hub # [ 0.003363] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] hub # [ 0.006354] Zone ranges: hub # [ 0.006355] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.006357] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] hub # [ 0.006358] Normal empty hub # [ 0.006359] Device empty hub # [ 0.006359] Movable zone start for each node hub # [ 0.006360] Early memory node ranges hub # [ 0.006361] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.006362] node 0: [mem 0x0000000000100000-0x000000007ffdafff] hub # [ 0.006363] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] hub # [ 0.006385] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006678] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.046295] On node 0, zone DMA32: 37 pages in unavailable ranges hub # [ 0.047289] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.047305] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.047344] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.047347] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.047348] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.047349] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.047351] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.047351] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.047354] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.047355] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.047360] TSC deadline timer available hub # [ 0.047365] CPU topo: Max. logical packages: 1 hub # [ 0.047365] CPU topo: Max. logical dies: 1 hub # [ 0.047366] CPU topo: Max. dies per package: 1 hub # [ 0.047369] CPU topo: Max. threads per core: 1 hub # [ 0.047370] CPU topo: Num. cores per package: 1 hub # [ 0.047370] CPU topo: Num. threads per package: 1 hub # [ 0.047370] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.047394] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.047434] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.047436] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.047437] [mem 0x80000000-0xfeffbfff] available for PCI devices hub # [ 0.047439] Booting paravirtualized kernel on KVM hub # [ 0.047443] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.051893] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.054299] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.054353] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.054354] 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/lbcz8i8z8byzw30pfqxnlddykhf423jk-nixos-system-hub-test/init regInfo=/nix/store/ars76gx14vnprghnr6ny8ih69s6amfzj-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.054451] Unknown kernel command line parameters "regInfo=/nix/store/ars76gx14vnprghnr6ny8ih69s6amfzj-closure-info/registration", will be passed to user space. hub # [ 0.054464] random: crng init done hub # [ 0.054464] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.056842] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.056864] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.056898] Fallback order for Node 0: 0 hub # [ 0.056901] Built 1 zonelists, mobility grouping on. Total pages: 524153 hub # [ 0.056902] Policy zone: DMA32 hub # [ 0.059921] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.064052] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.068955] allocated 4194304 bytes of page_ext hub # [ 0.079040] ftrace: allocating 48598 entries in 192 pages hub # [ 0.079042] ftrace: allocated 192 pages with 2 groups hub # [ 0.079915] Dynamic Preempt: lazy hub # [ 0.080109] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.080109] rcu: RCU event tracing is enabled. hub # [ 0.080110] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.080112] Trampoline variant of Tasks RCU enabled. hub # [ 0.080112] Rude variant of Tasks RCU enabled. hub # [ 0.080113] Tracing variant of Tasks RCU enabled. hub # [ 0.080113] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.080114] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.080137] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.080138] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.080140] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.084556] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.084841] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.084955] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.092097] Console: colour VGA+ 80x25 hub # [ 0.092101] printk: legacy console [tty0] enabled hub # [ 0.132594] printk: legacy console [ttyS0] enabled hub # [ 0.315687] ACPI: Core revision 20250807 hub # [ 0.317277] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.320094] APIC: Switch to symmetric I/O mode setup hub # [ 0.321797] x2apic enabled hub # [ 0.323014] APIC: Switched APIC routing to: physical x2apic hub # [ 0.325835] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.327652] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.330701] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) hub # [ 0.332819] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.333867] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.334700] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.335705] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.337700] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.338701] Transient Scheduler Attacks: Mitigation: Clear CPU buffers hub # [ 0.339700] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.340700] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.341700] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.342706] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.344700] active return thunk: srso_alias_return_thunk hub # [ 0.345729] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.347700] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.348700] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.350700] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.351700] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.352700] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.353700] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.354700] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 0.355700] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' hub # [ 0.357701] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.359699] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.360700] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.362700] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.363700] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.364700] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 hub # [ 0.365700] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 hub # [ 0.367700] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 0.403338] Freeing SMP alternatives memory: 44K hub # [ 0.403703] pid_max: default: 32768 minimum: 301 hub # [ 0.404825] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.405807] landlock: Up and running. hub # [ 0.406700] Yama: becoming mindful. hub # [ 0.408713] LSM support for eBPF active hub # [ 0.409820] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.410746] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.413929] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.415308] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.415711] ... version: 2 hub # [ 0.416702] ... bit width: 48 hub # [ 0.417702] ... generic counters: 6 hub # [ 0.418702] ... generic bitmap: 000000000000003f hub # [ 0.419702] ... fixed-purpose counters: 0 hub # [ 0.420702] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.421702] ... value mask: 0000ffffffffffff hub # [ 0.422702] ... max period: 00007fffffffffff hub # [ 0.423702] ... global_ctrl mask: 000000000000003f hub # [ 0.424827] signal: max sigframe size: 3376 hub # [ 0.425813] rcu: Hierarchical SRCU implementation. hub # [ 0.426706] rcu: Max phase no-delay instances is 400. hub # [ 0.432328] smp: Bringing up secondary CPUs ... hub # [ 0.432718] smp: Brought up 1 node, 1 CPU hub # [ 0.433705] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) hub # [ 0.434934] Memory: 1969256K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved) hub # [ 0.436007] devtmpfs: initialized hub # [ 0.436893] x86/mm: Memory block size: 128MB hub # [ 0.438872] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.439739] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.440731] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.441802] pinctrl core: initialized pinctrl subsystem hub # [ 0.443033] PM: RTC time: 16:23:03, date: 2026-07-13 hub # [ 0.446683] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.448227] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.448734] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.450018] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.450714] audit: initializing netlink subsys (disabled) hub # [ 0.452047] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.452050] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.452703] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.453706] audit: type=2000 audit(1783959782.900:1): state=initialized audit_enabled=0 res=1 hub # [ 0.455705] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.455707] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.456722] cpuidle: using governor menu hub # [ 0.459839] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.460997] PCI: Using configuration type 1 for base access hub # [ 0.461702] PCI: Using configuration type 1 for extended access hub # [ 0.462916] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.468014] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.468703] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.469703] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.476702] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.485109] ACPI: Added _OSI(Module Device) hub # [ 0.485703] ACPI: Added _OSI(Processor Device) hub # [ 0.490701] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.495594] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.499560] ACPI: Interpreter enabled hub # [ 0.500566] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.505702] ACPI: Using IOAPIC for interrupt routing hub # [ 0.506724] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.509701] PCI: Using E820 reservations for host bridge windows hub # [ 0.510853] ACPI: Enabled 2 GPEs in block 00 to 0F hub # [ 0.517664] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.518709] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.520087] acpiphp: Slot [3] registered hub # [ 0.520781] acpiphp: Slot [4] registered hub # [ 0.521757] acpiphp: Slot [5] registered hub # [ 0.522743] acpiphp: Slot [6] registered hub # [ 0.523741] acpiphp: Slot [7] registered hub # [ 0.524743] acpiphp: Slot [8] registered hub # [ 0.525759] acpiphp: Slot [9] registered hub # [ 0.526744] acpiphp: Slot [10] registered hub # [ 0.527743] acpiphp: Slot [11] registered hub # [ 0.528757] acpiphp: Slot [12] registered hub # [ 0.529745] acpiphp: Slot [13] registered hub # [ 0.530734] acpiphp: Slot [14] registered hub # [ 0.531735] acpiphp: Slot [15] registered hub # [ 0.532749] acpiphp: Slot [16] registered hub # [ 0.533735] acpiphp: Slot [17] registered hub # [ 0.534735] acpiphp: Slot [18] registered hub # [ 0.535767] acpiphp: Slot [19] registered hub # [ 0.536751] acpiphp: Slot [20] registered hub # [ 0.537735] acpiphp: Slot [21] registered hub # [ 0.538735] acpiphp: Slot [22] registered hub # [ 0.539735] acpiphp: Slot [23] registered hub # [ 0.540749] acpiphp: Slot [24] registered hub # [ 0.541735] acpiphp: Slot [25] registered hub # [ 0.542736] acpiphp: Slot [26] registered hub # [ 0.543749] acpiphp: Slot [27] registered hub # [ 0.544736] acpiphp: Slot [28] registered hub # [ 0.545758] acpiphp: Slot [29] registered hub # [ 0.546772] acpiphp: Slot [30] registered hub # [ 0.547755] acpiphp: Slot [31] registered hub # [ 0.548724] PCI host bridge to bus 0000:00 hub # [ 0.549708] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.550703] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.551703] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.552704] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] hub # [ 0.553703] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] hub # [ 0.554703] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.556046] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.557597] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.559612] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint hub # [ 0.562628] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] hub # [ 0.563766] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk hub # [ 0.564703] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk hub # [ 0.565702] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk hub # [ 0.566702] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk hub # [ 0.568080] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.569786] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] hub # [ 0.571965] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint hub # [ 0.573352] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI hub # [ 0.574717] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB hub # [ 0.576103] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.578784] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.579732] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.580754] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.581942] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.583809] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.586732] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.587717] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.588754] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.589717] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.592825] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.595737] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.596717] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.597754] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.600778] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.603702] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.604717] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.605754] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.608646] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.611638] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.612718] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.613753] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.616679] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.619795] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.620779] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.621753] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.624888] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.627739] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.628721] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.629755] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.633178] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.635738] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.636717] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.637754] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.638716] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.641693] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.643729] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.644754] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.647691] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.650619] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.651716] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.652753] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.655728] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.658667] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.659716] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.660754] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.669091] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.669908] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.670896] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.671894] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.672807] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 hub # [ 0.674972] iommu: Default domain type: Translated hub # [ 0.675712] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.677013] ACPI: bus type USB registered hub # [ 0.677773] usbcore: registered new interface driver usbfs hub # [ 0.678731] usbcore: registered new interface driver hub hub # [ 0.679712] usbcore: registered new device driver usb hub # [ 0.681735] NetLabel: Initializing hub # [ 0.682702] NetLabel: domain hash size = 128 hub # [ 0.683702] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.684803] NetLabel: unlabeled traffic allowed by default hub # [ 0.685717] PCI: Using ACPI for IRQ routing hub # [ 0.687448] pci 0000:00:02.0: vgaarb: setting as boot VGA device hub # [ 0.687697] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 0.687697] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.687706] vgaarb: loaded hub # [ 0.688853] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.689702] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.694817] clocksource: Switched to clocksource kvm-clock hub # [ 0.698993] VFS: Disk quotas dquot_6.6.0 hub # [ 0.700239] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.702447] pnp: PnP ACPI init hub # [ 0.704079] pnp: PnP ACPI: found 6 devices hub # [ 0.712337] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.714883] clocksource: Switched to clocksource acpi_pm hub # [ 0.716561] NET: Registered PF_INET protocol family hub # [ 0.718410] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.737176] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.739827] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.742147] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.744483] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.746713] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.748758] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.751011] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.752987] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.755111] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.756900] NET: Registered PF_XDP protocol family hub # [ 0.758397] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.760227] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.762054] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.764058] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] hub # [ 0.766070] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] hub # [ 0.768228] pci 0000:00:01.0: PIIX3: Enabling Passive Release hub # [ 0.769993] pci 0000:00:00.0: Limiting direct PCI/PCI transfers hub # [ 0.773343] ACPI: \_SB_.LNKD: Enabled at IRQ 11 hub # [ 0.776780] PCI: CLS 0 bytes, default 64 hub # [ 0.778337] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.781323] Trying to unpack rootfs image as initramfs... hub # [ 0.832992] Initialise system trusted keyrings hub # [ 0.836945] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.862487] Key type asymmetric registered hub # [ 0.863836] Asymmetric key parser 'x509' registered hub # [ 0.868954] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.874957] io scheduler mq-deadline registered hub # [ 0.876357] io scheduler kyber registered hub # [ 0.880505] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.886274] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.893131] Linux agpgart interface v0.103 hub # [ 0.894474] ACPI: bus type drm_connector registered hub # [ 0.901397] usbcore: registered new interface driver usbserial_generic hub # [ 0.903304] usbserial: USB Serial support registered for generic hub # [ 0.906906] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.906906] Please enable it if your BIOS has the CPPC option. hub # [ 0.910815] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.919052] drop_monitor: Initializing network drop monitor service hub # [ 0.921081] NET: Registered PF_INET6 protocol family hub # [ 0.927419] Segment Routing with IPv6 hub # [ 0.931964] In-situ OAM (IOAM) with IPv6 hub # [ 0.933611] IPI shorthand broadcast: enabled hub # [ 0.942475] sched_clock: Marking stable (703029047, 238849776)->(1135386924, -193508101) hub # [ 0.950108] registered taskstats version 1 hub # [ 0.951662] Loading compiled-in X.509 certificates hub # [ 0.973600] Demotion targets for Node 0: null hub # [ 0.977097] Key type .fscrypt registered hub # [ 0.980895] Key type fscrypt-provisioning registered hub # [ 0.982515] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.985899] ima: Allocated hash algorithm: sha1 hub # [ 0.987327] ima: No architecture policies found hub # [ 0.993115] PM: Magic number: 2:503:388 hub # [ 0.997392] RAS: Correctable Errors collector initialized. hub # [ 1.006824] clk: Disabling unused clocks hub # [ 1.009917] PM: genpd: Disabling unused power domains hub # [ 1.162068] Freeing initrd memory: 29496K hub # [ 1.166061] Freeing unused decrypted memory: 2028K hub # [ 1.169567] Freeing unused kernel image (initmem) memory: 3636K hub # [ 1.171439] Write protecting the kernel read-only data: 32768k hub # [ 1.174189] Freeing unused kernel image (text/rodata gap) memory: 1272K hub # [ 1.176603] Freeing unused kernel image (rodata/data gap) memory: 796K hub # [ 1.229659] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.231580] Run /init as init process hub # [ 1.243247] systemd[1]: Inserted module 'autofs4' hub # [ 1.260325] fuse: init (API version 7.45) hub # [ 1.267790] ACPI: \_SB_.LNKC: Enabled at IRQ 10 hub # [ 1.276458] ACPI: \_SB_.LNKA: Enabled at IRQ 10 hub # [ 1.281026] ACPI: \_SB_.LNKB: Enabled at IRQ 11 hub # [ 1.321976] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.661347] 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.682513] systemd[1]: Detected virtualization kvm. hub # [ 1.686414] systemd[1]: Detected architecture x86-64. hub # [ 1.690331] systemd[1]: Running in initrd. hub # [ 1.694570] systemd[1]: Initializing machine ID from random generator. hub # [ 1.699631] systemd[1]: Hostname set to . hub # [ 1.916393] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.975465] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.980601] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.982662] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.985181] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.987151] systemd[1]: Reached target Path Units. hub # [ 1.988731] systemd[1]: Reached target Slice Units. hub # [ 1.990325] systemd[1]: Reached target Swaps. hub # [ 1.991796] systemd[1]: Reached target Timer Units. hub # [ 1.993524] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.995702] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.997745] systemd[1]: Listening on Journal Sockets. hub # [ 1.999512] systemd[1]: Listening on udev Control Socket. hub # [ 2.001383] systemd[1]: Listening on udev Kernel Socket. hub # [ 2.003071] systemd[1]: Reached target Socket Units. hub # [ 2.005761] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 2.012976] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.024130] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.038986] systemd[1]: Starting Journal Service... hub # [ 2.053164] systemd[1]: Starting Load Kernel Modules... hub # [ 2.060032] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.077138] netfs: FS-Cache loaded hub # [ 2.082576] 9pnet: Installing 9P2000 support hub # [ 2.098093] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.112689] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.120343] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.127797] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.141528] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.151375] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.156201] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.163484] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.170643] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.173954] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.191119] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.214093] systemd[1]: Finished Load Kernel Modules. hub # [ 2.225347] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.244587] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.260363] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.278967] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.300790] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.307268] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.314992] systemd[1]: Reached target Local File Systems. hub # [ 2.323220] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.090126] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.092397] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.095476] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.344109] systemd[1]: Started Journal Service. hub # [ 2.128222] systemd[1]: Starting Create System Files and Directories... hub # [ 2.162368] systemd-udevd[74]: Using default interface naming scheme 'v261'. hub # [ 2.166133] systemd[1]: Finished Create System Files and Directories. hub # [ 2.200366] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.252161] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.253731] systemd[1]: Reached target System Initialization. hub # [ 2.255303] systemd[1]: Reached target Basic System. hub # [ 2.794677] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.820387] uhci_hcd 0000:00:01.2: UHCI Host Controller hub # [ 2.826603] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.843715] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.855016] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 hub # [ 2.861372] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 2.870661] SCSI subsystem initialized hub # [ 2.874968] uhci_hcd 0000:00:01.2: detected 2 ports hub # [ 2.880800] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 2.889629] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 hub # [ 2.907779] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.924056] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.688631] systemd[1]: Starting Virtual Console Setup... hub # [ 2.699330] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.957886] usb usb1: Product: UHCI Host Controller hub # [ 2.964810] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.731230] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker: QEMU running (pid 47) worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.TCLohLrqP4', fmt=raw size=1073741824 hub # [ 2.735743] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # mke2fs 1.47.4 (6-Mar-2025) (finished: start all VMs, in 3.87 seconds) worker # Discarding device blocks: 0/262144 done hub # [ 2.741160] systemd[1]: Finished Virtual Console Setup. worker # Creating filesystem with 262144 4k blocks and 65536 inodes hub # [ 2.982248] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd worker # Filesystem UUID: cedbdfd1-d98a-4e8a-92c1-cb530c8f2a80 hub: waiting for unit headscale worker # Superblock backups stored on blocks: hub # [ 2.748126] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. worker # 32768, 98304, 163840, 229376 hub: waiting for the VM to finish booting 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 worker # worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. hub # [ 2.996653] usb usb1: SerialNumber: 0000:00:01.2 hub # [ 3.002278] hub 1-0:1.0: USB hub found hub # [ 3.007659] hub 1-0:1.0: 2 ports detected hub # [ 2.798089] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.800232] systemd[1]: Reached target Initrd Root Device. hub # [ 2.805158] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 3.058972] scsi host0: ata_piix hub # [ 3.064711] scsi host1: ata_piix hub # [ 3.065702] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 hub # [ 3.072718] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # [ 2.841837] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.850243] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.873054] systemd[1]: Mounting /sysroot... worker # worker # worker # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1900+7EF31900 CA00 worker # Press Ctrl-B to configure iPXE (PCI 00:03.0)... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1900 7EF31900 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)... worker # worker # worker # Booting from ROM... hub # [ 3.228452] ata2: found unknown device (class 0) hub # [ 3.232610] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # Probing EDD (edd=off to disable)... ok hub # [ 3.236729] usb 1-1: new full-speed USB device number 2 using uhci_hcd hub # [ 3.245627] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 3.328882] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 3.345280] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 3.366469] EXT4-fs (vda): mounted filesystem c4057e23-0f6a-46ac-9e1e-fc2da1680a28 r/w with ordered data mode. Quota mode: none. hub # [ 3.134533] systemd[1]: Mounted /sysroot. hub # [ 3.137533] systemd[1]: Reached target Initrd Root File System. hub # [ 3.141506] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 3.146835] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.154157] systemd[1]: Mounting /sysroot/run... hub # [ 3.161829] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 3.170984] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 3.414478] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 3.416453] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 3.421870] usb 1-1: Product: QEMU USB Tablet hub # [ 3.424877] usb 1-1: Manufacturer: QEMU hub # [ 3.426753] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 hub # [ 3.193658] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 3.471452] hid: raw HID events driver (C) Jiri Kosina hub # [ 3.484217] 9p: Installing v9fs 9p2000 file system support hub # [ 3.265281] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 3.514802] usbcore: registered new interface driver usbhid hub # [ 3.278111] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.279541] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 3.280984] systemd[1]: Mounted /sysroot/run. hub # [ 3.283128] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.284509] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 3.529080] usbhid: USB HID core driver hub # [ 3.299108] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 3.301823] systemd[1]: Reloading... hub # [ 3.551896] 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 hub # [ 3.563235] 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.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 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/mbag9cg0xf4v35s7dx9hpf0iapxkbdin-nixos-system-worker-test/init regInfo=/nix/store/8mk68bw63nkc3ii8xnxg0c9pd3jw7zgg-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved worker # [ 0.000000] NX (Execute Disable) protection: active worker # [ 0.000000] APIC: Static calls initialized worker # [ 0.000000] SMBIOS 2.8 present. worker # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 worker # [ 0.000000] DMI: Memory slots populated: 1/1 worker # [ 0.000000] Hypervisor detected: KVM worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000001] kvm-clock: using sched offset of 487926739 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000005] tsc: Detected 2400.018 MHz processor worker # [ 0.000809] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000846] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000849] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.002750] found SMP MP-table at [mem 0x000f5470-0x000f547f] worker # [ 0.002761] Using GB pages for direct mapping worker # [ 0.002887] RAMDISK: [mem 0x7e2fa000-0x7ffcffff] worker # [ 0.002895] ACPI: Early table checksum verification disabled worker # [ 0.002897] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) worker # [ 0.002902] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002905] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002912] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002914] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002916] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 3.413737] systemd[1]: Reloading finished in 114 ms. worker # [ 0.002917] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002919] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002920] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] worker # [ 0.002921] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] worker # [ 0.002922] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002922] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] worker # [ 0.002923] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] hub # [ 3.424724] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace... worker # [ 0.002923] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] worker # [ 0.003396] No NUMA configuration found worker # [ 0.003397] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] worker # [ 0.003400] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] worker # [ 0.005922] Zone ranges: worker # [ 0.005923] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 3.432567] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace... worker # [ 0.005925] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] worker # [ 0.005926] Normal empty hub # [ 3.434962] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.005927] Device empty worker # [ 0.005928] Movable zone start for each node worker # [ 0.005929] Early memory node ranges hub # [ 3.438256] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 0.005929] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005930] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 3.441167] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 0.005931] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] worker # [ 0.005952] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 3.443149] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 0.006240] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.045410] On node 0, zone DMA32: 40 pages in unavailable ranges worker # [ 0.046389] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.046404] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.046439] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.046442] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.046443] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.046444] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.046445] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 3.456673] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.046446] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.046448] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 3.459304] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.046449] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.046460] TSC deadline timer available worker # [ 0.046465] CPU topo: Max. logical packages: 1 worker # [ 0.046466] CPU topo: Max. logical dies: 1 worker # [ 0.046466] CPU topo: Max. dies per package: 1 worker # [ 0.046469] CPU topo: Max. threads per core: 1 worker # [ 0.046470] CPU topo: Num. cores per package: 1 worker # [ 0.046470] CPU topo: Num. threads per package: 1 worker # [ 0.046471] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.046492] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.046531] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.046532] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.046534] [mem 0x80000000-0xfeffbfff] available for PCI devices worker # [ 0.046536] Booting paravirtualized kernel on KVM worker # [ 0.046539] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.050989] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.053317] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.053365] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.053366] 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/mbag9cg0xf4v35s7dx9hpf0iapxkbdin-nixos-system-worker-test/init regInfo=/nix/store/8mk68bw63nkc3ii8xnxg0c9pd3jw7zgg-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.053471] Unknown kernel command line parameters "regInfo=/nix/store/8mk68bw63nkc3ii8xnxg0c9pd3jw7zgg-closure-info/registration", will be passed to user space. worker # [ 0.053483] random: crng init done worker # [ 0.053484] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.055685] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.055707] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.055739] Fallback order for Node 0: 0 worker # [ 0.055742] Built 1 zonelists, mobility grouping on. Total pages: 524150 worker # [ 0.055744] Policy zone: DMA32 worker # [ 0.058488] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.062467] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.067029] allocated 4194304 bytes of page_ext worker # [ 0.076914] ftrace: allocating 48598 entries in 192 pages worker # [ 0.076916] ftrace: allocated 192 pages with 2 groups worker # [ 0.077763] Dynamic Preempt: lazy worker # [ 0.077938] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.077938] rcu: RCU event tracing is enabled. worker # [ 0.077939] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.077940] Trampoline variant of Tasks RCU enabled. worker # [ 0.077941] Rude variant of Tasks RCU enabled. worker # [ 0.077941] Tracing variant of Tasks RCU enabled. worker # [ 0.077942] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.077943] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.077964] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.077966] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.077966] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.082599] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.082893] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.083003] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.090177] Console: colour VGA+ 80x25 worker # [ 0.090181] printk: legacy console [tty0] enabled worker # [ 0.130695] printk: legacy console [ttyS0] enabled worker # [ 0.314127] ACPI: Core revision 20250807 worker # [ 0.315667] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.318377] APIC: Switch to symmetric I/O mode setup worker # [ 0.320121] x2apic enabled worker # [ 0.321343] APIC: Switched APIC routing to: physical x2apic worker # [ 0.324201] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.326001] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns worker # [ 0.329026] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) worker # [ 0.331144] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.332186] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.333025] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.334030] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.336025] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.337025] Transient Scheduler Attacks: Mitigation: Clear CPU buffers worker # [ 0.338024] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.339025] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.340024] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.341032] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.343026] active return thunk: srso_alias_return_thunk worker # [ 0.344054] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.346025] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.347025] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.349025] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.350024] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.351025] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' worker # [ 0.352025] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.353024] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' worker # [ 0.354024] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' worker # [ 0.356025] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.357025] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 worker # [ 0.358024] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 worker # [ 0.360025] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.361025] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.362025] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 worker # [ 0.363025] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 worker # [ 0.364024] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. worker # [ 0.399996] Freeing SMP alternatives memory: 44K worker # [ 0.401026] pid_max: default: 32768 minimum: 301 worker # [ 0.402135] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.404141] landlock: Up and running. worker # [ 0.405868] Yama: becoming mindful. worker # [ 0.407237] LSM support for eBPF active worker # [ 0.408142] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.410068] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.413213] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.414610] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.415035] ... version: 2 worker # [ 0.416026] ... bit width: 48 worker # [ 0.417026] ... generic counters: 6 worker # [ 0.418026] ... generic bitmap: 000000000000003f worker # [ 0.419026] ... fixed-purpose counters: 0 worker # [ 0.420026] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.421026] ... value mask: 0000ffffffffffff worker # [ 0.422026] ... max period: 00007fffffffffff worker # [ 0.423026] ... global_ctrl mask: 000000000000003f worker # [ 0.424149] signal: max sigframe size: 3376 worker # [ 0.425140] rcu: Hierarchical SRCU implementation. worker # [ 0.426030] rcu: Max phase no-delay instances is 400. worker # [ 0.431724] smp: Bringing up secondary CPUs ... worker # [ 0.433040] smp: Brought up 1 node, 1 CPU worker # [ 0.434029] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) worker # [ 0.435210] Memory: 1969184K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved) worker # [ 0.436314] devtmpfs: initialized worker # [ 0.437228] x86/mm: Memory block size: 128MB worker # [ 0.439185] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.440062] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.441055] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.442115] pinctrl core: initialized pinctrl subsystem worker # [ 0.443348] PM: RTC time: 16:23:06, date: 2026-07-13 worker # [ 0.446883] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.448567] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.449058] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.450322] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.451039] audit: initializing netlink subsys (disabled) worker # [ 0.452261] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.452263] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.453028] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.454030] audit: type=2000 audit(1783959786.556:1): state=initialized audit_enabled=0 res=1 worker # [ 0.456029] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.456031] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.457047] cpuidle: using governor menu worker # [ 0.460175] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.461299] PCI: Using configuration type 1 for base access worker # [ 0.462027] PCI: Using configuration type 1 for extended access worker # [ 0.463272] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.468318] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.469027] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.474026] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.475027] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.485415] ACPI: Added _OSI(Module Device) worker # [ 0.486028] ACPI: Added _OSI(Processor Device) worker # [ 0.491026] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.495892] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.499933] ACPI: Interpreter enabled worker # [ 0.500901] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.504027] ACPI: Using IOAPIC for interrupt routing worker # [ 0.505050] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.508025] PCI: Using E820 reservations for host bridge windows worker # [ 0.509186] ACPI: Enabled 2 GPEs in block 00 to 0F worker # [ 0.517896] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.519034] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.520448] acpiphp: Slot [3] registered worker # [ 0.521070] acpiphp: Slot [4] registered worker # [ 0.522094] acpiphp: Slot [5] registered worker # [ 0.523122] acpiphp: Slot [6] registered worker # [ 0.524067] acpiphp: Slot [7] registered worker # [ 0.525068] acpiphp: Slot [8] registered worker # [ 0.526082] acpiphp: Slot [9] registered worker # [ 0.527066] acpiphp: Slot [10] registered worker # [ 0.528068] acpiphp: Slot [11] registered worker # [ 0.529122] acpiphp: Slot [12] registered worker # [ 0.530077] acpiphp: Slot [13] registered worker # [ 0.531059] acpiphp: Slot [14] registered worker # [ 0.532059] acpiphp: Slot [15] registered worker # [ 0.533073] acpiphp: Slot [16] registered worker # [ 0.534073] acpiphp: Slot [17] registered worker # [ 0.535059] acpiphp: Slot [18] registered worker # [ 0.536060] acpiphp: Slot [19] registered worker # [ 0.537074] acpiphp: Slot [20] registered worker # [ 0.538060] acpiphp: Slot [21] registered worker # [ 0.539059] acpiphp: Slot [22] registered worker # [ 0.540067] acpiphp: Slot [23] registered worker # [ 0.541073] acpiphp: Slot [24] registered worker # [ 0.542060] acpiphp: Slot [25] registered worker # [ 0.543059] acpiphp: Slot [26] registered worker # [ 0.544078] acpiphp: Slot [27] registered worker # [ 0.545060] acpiphp: Slot [28] registered worker # [ 0.546083] acpiphp: Slot [29] registered worker # [ 0.547073] acpiphp: Slot [30] registered worker # [ 0.548079] acpiphp: Slot [31] registered worker # [ 0.549049] PCI host bridge to bus 0000:00 worker # [ 0.550034] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.551028] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.552028] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.553027] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] worker # [ 0.554027] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] worker # [ 0.555028] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.556417] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.557931] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 3.876650] systemd[1]: Mounting /sysroot/nix/store... worker # [ 0.559934] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint worker # [ 0.562837] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f] worker # [ 0.564091] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk worker # [ 0.565027] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk worker # [ 0.566027] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk worker # [ 0.567027] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk worker # [ 0.568402] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.570112] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f] worker # [ 0.572279] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint worker # [ 0.573671] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI worker # [ 0.575041] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB worker # [ 0.576422] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.579122] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.580057] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.581079] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.582270] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.584096] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 3.928124] systemd[1]: Mounted /sysroot/nix/store. worker # [ 0.587062] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] hub # [ 3.929560] systemd[1]: Reached target Initrd File Systems. worker # [ 0.588041] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 3.932142] systemd[1]: Starting Find NixOS closure... worker # [ 0.589078] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.590041] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 3.935730] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 0.593249] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.596009] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.597041] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.598079] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.601005] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.603060] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.604041] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 3.958163] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 0.605078] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 3.961727] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 0.608002] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 3.971552] systemd[1]: Finished Find NixOS closure. hub # [ 3.973684] systemd[1]: Reached target Initrd Default Target. hub # [ 3.976283] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 0.610682] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.612043] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.613078] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.616018] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 3.991414] systemd[1]: Stopped target Initrd Default Target. worker # [ 0.619064] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] hub # [ 3.993226] systemd[1]: Stopped target Basic System. worker # [ 0.620042] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 3.996088] systemd[1]: Stopped target Initrd Root Device. worker # [ 0.621079] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 3.997552] systemd[1]: Stopped target Path Units. hub # [ 3.999093] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 0.624019] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 4.000972] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 4.002964] systemd[1]: Stopped target Slice Units. hub # [ 4.004726] systemd[1]: Stopped target Socket Units. worker # [ 0.627094] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.628041] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 4.006575] systemd[1]: Stopped target System Initialization. worker # [ 0.629078] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 4.009231] systemd[1]: Stopped target Swaps. hub # [ 4.010593] systemd[1]: Stopped target Timer Units. hub # [ 4.011991] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 0.632563] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 4.014058] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.015783] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 0.634041] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff] hub # [ 4.018159] systemd[1]: Stopped Find NixOS closure. worker # [ 0.635041] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.636100] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 4.020215] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 0.637041] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 4.022905] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.024803] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 0.640027] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 4.027308] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.028753] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 0.642054] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.643081] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 4.032209] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.033600] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.035565] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 0.646011] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 4.037519] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 0.648754] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f] hub # [ 4.039677] systemd[1]: Stopped Create System Files and Directories. worker # [ 0.650041] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 4.041817] systemd[1]: Stopped target Local File Systems. worker # [ 0.651078] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 4.043790] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.047666] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 0.654077] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 4.049525] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 0.656053] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f] hub # [ 4.050958] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 0.657042] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 4.053624] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 0.658099] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 4.056216] systemd[1]: Stopped Virtual Console Setup. worker # [ 0.666224] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 4.065963] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 0.667242] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.668249] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.669254] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 4.071516] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 0.670137] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 worker # [ 0.672214] iommu: Default domain type: Translated worker # [ 0.673037] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.674324] ACPI: bus type USB registered worker # [ 0.675093] usbcore: registered new interface driver usbfs worker # [ 0.676057] usbcore: registered new interface driver hub hub # [ 4.081439] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 0.677037] usbcore: registered new device driver usb hub # [ 4.083423] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 0.678940] NetLabel: Initializing worker # [ 0.679855] NetLabel: domain hash size = 128 hub # [ 4.086070] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.681026] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 4.088678] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.682070] NetLabel: unlabeled traffic allowed by default worker # [ 0.683042] PCI: Using ACPI for IRQ routing hub # [ 4.091359] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 0.684683] pci 0000:00:02.0: vgaarb: setting as boot VGA device hub # [ 4.094257] systemd[1]: Closed udev Control Socket. worker # [ 0.685022] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 4.096224] systemd[1]: Starting Cleanup udev Database... worker # [ 0.685022] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.685029] vgaarb: loaded hub # [ 4.097778] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 0.686156] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 4.100233] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 0.687027] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 4.101865] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.104223] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.107226] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.108983] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 0.694116] clocksource: Switched to clocksource kvm-clock worker # [ 0.698251] VFS: Disk quotas dquot_6.6.0 worker # [ 0.699496] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.701748] pnp: PnP ACPI init worker # [ 0.703411] pnp: PnP ACPI: found 6 devices hub # [ 4.125874] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 0.711600] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 4.127967] systemd[1]: Finished Cleanup udev Database. worker # [ 0.714158] clocksource: Switched to clocksource acpi_pm hub # [ 4.130354] systemd[1]: Reached target Switch Root. worker # [ 0.715876] NET: Registered PF_INET protocol family hub # [ 4.132838] systemd[1]: Starting NixOS Activation... worker # [ 0.717745] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.736739] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.739391] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.741680] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.744023] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) worker # [ 0.746243] TCP: Hash tables configured (established 16384 bind 16384) worker # [ 0.748229] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) worker # [ 0.750409] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.752340] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.754472] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.756203] NET: Registered PF_XDP protocol family worker # [ 0.757725] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.759513] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.761320] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.763283] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] worker # [ 0.765267] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] worker # [ 0.767389] pci 0000:00:01.0: PIIX3: Enabling Passive Release worker # [ 0.769109] pci 0000:00:00.0: Limiting direct PCI/PCI transfers worker # [ 0.772462] ACPI: \_SB_.LNKD: Enabled at IRQ 11 worker # [ 0.775868] PCI: CLS 0 bytes, default 64 worker # [ 0.777396] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns worker # [ 0.780335] Trying to unpack rootfs image as initramfs... worker # [ 0.828532] Initialise system trusted keyrings worker # [ 0.833273] workingset: timestamp_bits=40 max_order=19 bucket_order=0 worker # [ 0.858363] Key type asymmetric registered worker # [ 0.859679] Asymmetric key parser 'x509' registered worker # [ 0.863229] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.870230] io scheduler mq-deadline registered worker # [ 0.871666] io scheduler kyber registered worker # [ 0.875775] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.877994] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.886346] Linux agpgart interface v0.103 worker # [ 0.887697] ACPI: bus type drm_connector registered hub # [ 4.302627] initrd-nixos-activation-start[181]: booting system configuration /nix/store/lbcz8i8z8byzw30pfqxnlddykhf423jk-nixos-system-hub-test worker # [ 0.893572] usbcore: registered new interface driver usbserial_generic worker # [ 0.895482] usbserial: USB Serial support registered for generic worker # [ 0.901177] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. worker # [ 0.901177] Please enable it if your BIOS has the CPPC option. worker # [ 0.905103] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.911321] drop_monitor: Initializing network drop monitor service worker # [ 0.913284] NET: Registered PF_INET6 protocol family worker # [ 0.920731] Segment Routing with IPv6 worker # [ 0.921943] In-situ OAM (IOAM) with IPv6 worker # [ 0.925554] IPI shorthand broadcast: enabled worker # [ 0.934334] sched_clock: Marking stable (695028089, 239121424)->(1124995092, -190845579) worker # [ 0.942421] registered taskstats version 1 worker # [ 0.943952] Loading compiled-in X.509 certificates hub # [ 4.372120] initrd-nixos-activation-start[181]: running activation script... worker # [ 0.966089] Demotion targets for Node 0: null worker # [ 0.969328] Key type .fscrypt registered worker # [ 0.972258] Key type fscrypt-provisioning registered worker # [ 0.973914] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.980200] ima: Allocated hash algorithm: sha1 worker # [ 0.981684] ima: No architecture policies found worker # [ 0.986173] PM: Magic number: 2:503:388 worker # [ 0.990417] RAS: Correctable Errors collector initialized. worker # [ 0.999875] clk: Disabling unused clocks worker # [ 1.003178] PM: genpd: Disabling unused power domains worker # [ 1.147074] Freeing initrd memory: 29528K worker # [ 1.151081] Freeing unused decrypted memory: 2028K worker # [ 1.154646] Freeing unused kernel image (initmem) memory: 3636K worker # [ 1.156513] Write protecting the kernel read-only data: 32768k worker # [ 1.159282] Freeing unused kernel image (text/rodata gap) memory: 1272K worker # [ 1.161717] Freeing unused kernel image (rodata/data gap) memory: 796K worker # [ 1.214732] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.216649] Run /init as init process worker # [ 1.228179] systemd[1]: Inserted module 'autofs4' worker # [ 1.245326] fuse: init (API version 7.45) worker # [ 1.252796] ACPI: \_SB_.LNKC: Enabled at IRQ 10 worker # [ 1.261679] ACPI: \_SB_.LNKA: Enabled at IRQ 10 worker # [ 1.266291] ACPI: \_SB_.LNKB: Enabled at IRQ 11 worker # [ 1.306330] systemd[1]: Successfully made /usr/ read-only. hub # [ 4.827516] initrd-nixos-activation-start[204]: setting up /etc... worker # [ 1.643393] 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.651941] systemd[1]: Detected virtualization kvm. worker # [ 1.653554] systemd[1]: Detected architecture x86-64. worker # [ 1.655096] systemd[1]: Running in initrd. worker # [ 1.656789] systemd[1]: Initializing machine ID from random generator. worker # [ 1.658847] systemd[1]: Hostname set to . hub # [ 5.127514] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.130319] systemd[1]: Finished NixOS Activation. hub # [ 5.133283] systemd[1]: Starting Switch Root... hub # [ 5.147326] systemd[1]: Switching root. worker # [ 1.746902] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 1.791684] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 1.796807] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.798896] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.801401] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.803399] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.805321] systemd[1]: Reached target Path Units. worker # [ 1.806868] systemd[1]: Reached target Slice Units. worker # [ 1.808457] systemd[1]: Reached target Swaps. worker # [ 1.809926] systemd[1]: Reached target Timer Units. worker # [ 1.811655] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 1.813794] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 1.815786] systemd[1]: Listening on Journal Sockets. worker # [ 1.817520] systemd[1]: Listening on udev Control Socket. worker # [ 1.819299] systemd[1]: Listening on udev Kernel Socket. worker # [ 1.820999] systemd[1]: Reached target Socket Units. worker # [ 1.823755] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 1.829820] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 1.840266] systemd[1]: Starting Load Kernel Module configfs... worker # [ 1.853397] systemd[1]: Starting Journal Service... hub # [ 5.518026] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 1.870289] systemd[1]: Starting Load Kernel Modules... worker # [ 1.876150] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.894185] netfs: FS-Cache loaded worker # [ 1.899893] 9pnet: Installing 9P2000 support worker # [ 1.920370] systemd[1]: Starting Coldplug All udev Devices... worker # [ 1.932945] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 1.939327] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 1.946254] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 1.950949] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 1.960205] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 1.963200] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 1.969698] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 1.981814] systemd[1]: Finished Load Kernel Module configfs. worker # [ 1.991890] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.006383] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 5.677112] NET: Registered PF_VSOCK protocol family worker # [ 2.024684] systemd[1]: Finished Load Kernel Modules. worker # [ 2.036664] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.054797] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.069257] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.089280] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.110310] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.116580] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.123259] systemd[1]: Reached target Local File Systems. worker # [ 2.132433] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 1.896204] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 1.899662] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 1.902487] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.151381] systemd[1]: Started Journal Service. worker # [ 1.935339] systemd[1]: Starting Create System Files and Directories... worker # [ 1.968978] systemd-udevd[75]: Using default interface naming scheme 'v261'. worker # [ 1.970981] systemd[1]: Finished Create System Files and Directories. worker # [ 2.006573] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.065108] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.066728] systemd[1]: Reached target System Initialization. worker # [ 2.068322] systemd[1]: Reached target Basic System. hub # [ 6.064769] 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.081077] systemd[1]: Detected virtualization kvm. hub # [ 6.084219] systemd[1]: Detected architecture x86-64. hub # [ 6.087461] systemd[1]: Detected first boot. hub # [ 6.094372] systemd[1]: Initializing machine ID from random generator. worker # [ 2.585543] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.620466] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.641448] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.646215] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.662082] uhci_hcd 0000:00:01.2: UHCI Host Controller worker # [ 2.663378] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 worker # [ 2.668931] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # [ 2.672983] SCSI subsystem initialized worker # [ 2.687190] uhci_hcd 0000:00:01.2: detected 2 ports hub # [ 6.344091] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.699398] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.703097] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c140 worker # [ 2.715874] virtio_blk virtio5: [vdb] 2081912 512-byte logical blocks (1.07 GB/1017 MiB) worker # [ 2.718896] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.496681] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.743450] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.507255] systemd[1]: Starting Virtual Console Setup... worker # [ 2.759881] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.527443] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.531698] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.787156] usb usb1: Product: UHCI Host Controller worker # [ 2.551361] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.557794] systemd[1]: Finished Virtual Console Setup. worker # [ 2.807389] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd worker # [ 2.817853] usb usb1: SerialNumber: 0000:00:01.2 worker # [ 2.824075] hub 1-0:1.0: USB hub found worker # [ 2.827227] hub 1-0:1.0: 2 ports detected hub # [ 6.484249] systemd[1]: Applying preset policy. worker # [ 2.620814] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.867399] scsi host0: ata_piix worker # [ 2.630106] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.632208] systemd[1]: Reached target Initrd Root Device. worker # [ 2.635392] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.881179] scsi host1: ata_piix worker # [ 2.884683] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 0 worker # [ 2.886450] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 0 worker # [ 2.669338] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.677213] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.697796] systemd[1]: Mounting /sysroot... worker # [ 3.050358] usb 1-1: new full-speed USB device number 2 using uhci_hcd worker # [ 3.054774] ata2: found unknown device (class 0) worker # [ 3.061778] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.069792] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.136144] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.152570] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.175260] EXT4-fs (vda): mounted filesystem cedbdfd1-d98a-4e8a-92c1-cb530c8f2a80 r/w with ordered data mode. Quota mode: none. worker # [ 2.942879] systemd[1]: Mounted /sysroot. worker # [ 2.944838] systemd[1]: Reached target Initrd Root File System. worker # [ 2.949352] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 2.965584] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 2.973101] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 2.976964] systemd[1]: Reloading... worker # [ 3.228594] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.230529] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.236293] usb 1-1: Product: QEMU USB Tablet worker # [ 3.238820] usb 1-1: Manufacturer: QEMU worker # [ 3.239981] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 3.279076] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.300217] usbcore: registered new interface driver usbhid worker # [ 3.306003] usbhid: USB HID core driver worker # [ 3.321353] 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.334250] 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 hub # [ 7.022535] systemd[1]: Populated /etc with preset unit settings. worker # [ 3.145236] systemd[1]: Reloading finished in 169 ms. worker # [ 3.155126] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace... worker # [ 3.161321] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace... worker # [ 3.167098] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.169669] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.172201] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.175141] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 7.594558] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 7.597085] systemd[1]: Stopped initrd-switch-root.service. worker # [ 3.703283] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 7.601012] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 7.604255] systemd[1]: Created slice Slice /system/getty. worker # [ 3.711299] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 7.606336] systemd[1]: Created slice User and Session Slice. hub # [ 7.607947] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 7.609986] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 7.611864] systemd[1]: Expecting device /dev/hvc0... hub # [ 7.613099] systemd[1]: Expecting device /dev/ttyS0... hub # [ 7.614412] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 7.615881] systemd[1]: Stopped target initrd-fs.target. hub # [ 7.617193] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 3.723288] systemd[1]: Mounting /sysroot/run... hub # [ 7.618610] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 7.620139] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 7.621762] systemd[1]: Reached target Path Units. hub # [ 7.623060] systemd[1]: Reached target Remote File Systems. hub # [ 7.624455] systemd[1]: Reached target Slice Units. hub # [ 7.625765] systemd[1]: Reached target Swaps. hub # [ 7.630130] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 3.737461] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 7.635099] systemd[1]: Listening on Process Core Dump Socket. hub # [ 7.638954] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 7.642727] systemd[1]: Listening on Factory Reset Management. hub # [ 7.644343] systemd[1]: Listening on Hostname Service Socket. hub # [ 7.649437] systemd[1]: Starting Journal Log Access Socket... worker # [ 3.758229] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 7.652300] systemd[1]: Listening on Journal Audit Socket. hub # [ 7.656511] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 7.658724] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 7.660965] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.663160] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 7.674742] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 7.676542] systemd[1]: Listening on udev Control Socket. hub # [ 7.678114] systemd[1]: Listening on udev Varlink Socket. hub # [ 7.682964] systemd[1]: Mounting Huge Pages File System... hub # [ 7.687290] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 3.795288] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.797115] systemd[1]: Mounted /sysroot/run. hub # [ 7.695501] systemd[1]: Mounting Kernel Debug File System... worker # [ 4.045366] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 4.048228] 9p: Installing v9fs 9p2000 file system support hub # [ 7.703321] systemd[1]: Mounting Kernel Trace File System... worker # [ 3.813629] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 7.709351] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 7.714568] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 3.826410] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.828359] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.830325] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 7.726529] systemd[1]: Starting Load Kernel Module configfs... hub # [ 7.728142] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 7.731311] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 3.840538] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 7.734278] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 3.843151] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 7.744870] systemd[1]: Mounting FUSE Control File System... hub # [ 7.746764] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 7.788087] systemd[1]: Starting Journal Service... hub # [ 7.812438] systemd[1]: Starting Load Kernel Modules... hub # [ 7.829907] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 7.841142] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 7.849650] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.863981] systemd-journald[274]: Collecting audit messages is enabled. hub # [ 7.868236] systemd[1]: Starting Coldplug All udev Devices... hub # [ 7.899692] systemd[1]: Listening on Journal Log Access Socket. hub # [ 7.907288] loop: module loaded hub # [ 7.911991] systemd[1]: Mounted Huge Pages File System. hub # [ 7.919083] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 7.927461] systemd[1]: Mounted Kernel Debug File System. hub # [ 7.932942] EXT4-fs (vda): re-mounted c4057e23-0f6a-46ac-9e1e-fc2da1680a28. hub # [ 7.698110] systemd[1]: Queued start job for default target Multi-User System. hub # [ 7.700401] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 7.941039] systemd[1]: Started Journal Service. hub # [ 7.707351] systemd-modules-load[275]: Inserted module 'loop' hub # [ 7.714406] systemd[1]: Mounted Kernel Trace File System. hub # [ 7.724663] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 7.731143] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 7.735436] systemd-modules-load[275]: Inserted module 'tls' hub # [ 7.737206] systemd[1]: Finished Load Kernel Module configfs. hub # [ 7.739976] systemd[1]: Mounted FUSE Control File System. hub # [ 7.743427] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 7.748312] systemd[1]: Finished Load Kernel Modules. hub # [ 7.769676] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 7.777235] systemd[1]: Mounting Kernel Configuration File System... hub # [ 7.784115] systemd[1]: Starting Firewall... hub # [ 7.787483] systemd-oomd[277]: No swap; memory pressure usage will be degraded hub # [ 7.803780] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 7.805506] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 7.818755] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 7.829262] systemd[1]: Starting Apply Kernel Variables... hub # [ 7.850127] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 7.852909] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.863226] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 8.116076] systemd-journald[274]: Received client request to flush runtime journal. hub # [ 8.103610] systemd[1]: Mounted Kernel Configuration File System. hub # [ 8.108745] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 8.116140] systemd[1]: Reached target First Boot Complete. hub # [ 8.119340] systemd[1]: Finished Apply Kernel Variables. hub # [ 8.122453] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 8.128059] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 8.131663] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 8.159364] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 8.163094] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 8.170523] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 8.257346] systemd[1]: Finished Coldplug All udev Devices. hub # [ 8.269938] systemd-udevd[317]: Using default interface naming scheme 'v261'. worker # [ 4.702322] systemd[1]: Mounting /sysroot/nix/store... hub # [ 8.361490] systemd[1]: Mounting /run/wrappers... worker # [ 4.743929] systemd[1]: Mounted /sysroot/nix/store. worker # [ 4.746122] systemd[1]: Reached target Initrd File Systems. hub # [ 8.402192] systemd[1]: Mounted /run/wrappers. worker # [ 4.749096] systemd[1]: Starting Find NixOS closure... hub # [ 8.404082] systemd[1]: Reached target Local File Systems. hub # [ 8.408677] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 4.754547] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 8.413158] systemd[1]: Starting register-nix-paths.service... hub # [ 8.419110] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 8.421302] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 4.776386] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 4.780517] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 8.437146] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 4.789873] systemd[1]: Finished Find NixOS closure. worker # [ 4.792251] systemd[1]: Reached target Initrd Default Target. worker # [ 4.794680] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 8.449292] systemd[1]: Starting Create System Files and Directories... hub # [ 8.453415] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 4.811283] systemd[1]: Stopped target Initrd Default Target. worker # [ 4.813509] systemd[1]: Stopped target Basic System. worker # [ 4.815200] systemd[1]: Stopped target Initrd Root Device. worker # [ 4.818193] systemd[1]: Stopped target Path Units. worker # [ 4.819738] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 4.821663] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 4.823604] systemd[1]: Stopped target Slice Units. worker # [ 4.824986] systemd[1]: Stopped target Socket Units. worker # [ 4.826840] systemd[1]: Stopped target System Initialization. worker # [ 4.828787] systemd[1]: Stopped target Swaps. worker # [ 4.830631] systemd[1]: Stopped target Timer Units. worker # [ 4.832829] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.834375] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 4.837150] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 4.839148] systemd[1]: Stopped Find NixOS closure. worker # [ 4.840632] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 4.843318] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 4.845192] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 4.847218] systemd[1]: Stopped Apply Kernel Variables. worker # [ 4.849330] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 4.851342] systemd[1]: Stopped Load Kernel Modules. worker # [ 4.853232] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 4.856216] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 4.858211] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 4.860095] systemd[1]: Stopped Create System Files and Directories. worker # [ 4.863206] systemd[1]: Stopped target Local File Systems. worker # [ 4.864686] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 4.867229] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 4.869457] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 4.872556] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 4.874446] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 8.530128] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 4.876967] systemd[1]: Stopped Virtual Console Setup. hub # [ 8.542344] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 4.888079] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 4.893144] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 4.900349] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 4.902392] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 4.904890] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 4.907414] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 4.911116] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 4.912969] systemd[1]: Closed udev Control Socket. worker # [ 4.915190] systemd[1]: Starting Cleanup udev Database... worker # [ 4.917246] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 4.919232] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 4.921241] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 4.924246] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 4.926141] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 4.928354] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 4.944772] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 4.947177] systemd[1]: Finished Cleanup udev Database. worker # [ 4.949927] systemd[1]: Reached target Switch Root. worker # [ 4.951613] systemd[1]: Starting NixOS Activation... hub # [ 8.618417] systemd[1]: Finished Create System Files and Directories. hub # [ 8.634363] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 8.643666] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 5.005877] initrd-nixos-activation-start[183]: booting system configuration /nix/store/mbag9cg0xf4v35s7dx9hpf0iapxkbdin-nixos-system-worker-test worker # [ 5.025892] initrd-nixos-activation-start[183]: running activation script... hub # [ 8.727618] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 8.791128] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 8.801378] systemd[1]: Starting Update is Completed... worker # [ 5.162502] initrd-nixos-activation-start[206]: setting up /etc... hub # [ 8.865750] systemd[1]: Finished Update is Completed. worker # [ 5.238234] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 5.240949] systemd[1]: Finished NixOS Activation. worker # [ 5.243935] systemd[1]: Starting Switch Root... worker # [ 5.257637] systemd[1]: Switching root. hub # [ 9.018106] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.622542] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 5.687786] NET: Registered PF_VSOCK protocol family hub # [ 9.169345] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 9.174228] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 9.224311] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. hub # [ 9.306168] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 9.349222] (udev-worker)[396]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 9.353897] (udev-worker)[396]: Network interface NamePolicy= disabled on kernel command line. hub # [ 9.358647] (udev-worker)[408]: Network interface NamePolicy= disabled on kernel command line. hub # [ 9.462787] systemd[1]: Finished register-nix-paths.service. hub # [ 9.465141] systemd[1]: Reached target System Initialization. hub # [ 9.469267] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 9.472312] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 9.474430] systemd[1]: Reached target Timer Units. worker # [ 6.045008] 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 # [ 9.476394] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 6.061249] systemd[1]: Detected virtualization kvm. hub # [ 9.480454] systemd[1]: Listening on Nix Daemon Socket. worker # [ 6.064276] systemd[1]: Detected architecture x86-64. hub # [ 9.482683] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 6.067589] systemd[1]: Detected first boot. hub # [ 9.485268] systemd[1]: Reached target Socket Units. hub # [ 9.487571] systemd[1]: Reached target Basic System. worker # [ 6.071375] systemd[1]: Initializing machine ID from random generator. hub # [ 9.490101] systemd[1]: Started backdoor.service. hub # [ 9.498455] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 9.510551] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 9.527463] systemd[1]: Starting Post-Boot Actions... hub # [ 9.544887] systemd[1]: Started Reset console on configuration changes. hub # [ 9.576922] systemd[1]: Starting resolvconf update... hub # connecting to host... hub # [ 9.658684] systemd[1]: Starting D-Bus System Message Bus... hub # [ 9.669116] systemd[1]: Finished Post-Boot Actions. hub # [ 9.675477] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 9.679311] nsncd[500]: Jul 13 16:23:12.354 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.699604] systemd[1]: Finished Firewall. hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 6.96 seconds) hub: (finished: waiting for the VM to finish booting, in 6.96 seconds) worker # [ 6.302040] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 9.719885] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 9.730894] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 9.737898] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 9.741649] systemd[1]: Reached target User and Group Name Lookups. hub # [ 9.760700] systemd[1]: Starting User Login Management... worker # [ 6.411364] systemd[1]: Applying preset policy. hub # [ 9.881691] dbus-broker-launch[517]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 9.900412] dbus-broker-launch[517]: NSS returned no entry for 'systemd-timesync' hub # [ 9.903251] dbus-broker-launch[517]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" hub # [ 9.922073] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 9.925120] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 9.927683] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 9.932674] systemd[1]: Stopping User and Group Name Lookups... hub # [ 9.936341] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 9.945361] systemd[1]: nscd.service: Deactivated successfully. worker # [ 6.533216] systemd[1]: Populated /etc with preset unit settings. hub # [ 9.950989] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 9.965521] systemd[1]: Started D-Bus System Message Bus. hub # [ 9.969559] systemd-logind[539]: New seat seat0. hub # [ 10.005591] dbus-broker-launch[517]: Ready hub # [ 10.014117] systemd[1]: Started User Login Management. hub # [ 10.035783] systemd[1]: Starting linger-users.service... hub # [ 10.048547] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 6.642348] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 6.644728] systemd[1]: Stopped initrd-switch-root.service. worker # [ 6.647866] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 6.651150] systemd[1]: Created slice Slice /system/getty. worker # [ 6.653220] systemd[1]: Created slice User and Session Slice. worker # [ 6.654804] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 6.656893] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 6.658839] systemd[1]: Expecting device /dev/hvc0... worker # [ 6.660194] systemd[1]: Expecting device /dev/ttyS0... worker # [ 6.661597] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 6.663100] systemd[1]: Stopped target initrd-fs.target. worker # [ 6.664426] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 6.665870] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 10.081286] systemd[1]: Finished resolvconf update. worker # [ 6.667403] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 6.669034] systemd[1]: Reached target Path Units. worker # [ 6.670325] systemd[1]: Reached target Remote File Systems. worker # [ 6.671730] systemd[1]: Reached target Slice Units. worker # [ 6.673017] systemd[1]: Reached target Swaps. hub # [ 10.089311] systemd[1]: Reached target Preparation for Network. worker # [ 6.675044] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 6.677920] systemd[1]: Listening on Process Core Dump Socket. worker # [ 6.680010] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 6.682421] systemd[1]: Listening on Factory Reset Management. worker # [ 6.684048] systemd[1]: Listening on Hostname Service Socket. hub # [ 10.101558] systemd[1]: Starting DHCP Client... worker # [ 6.687564] systemd[1]: Starting Journal Log Access Socket... worker # [ 6.690147] systemd[1]: Listening on Journal Audit Socket. worker # [ 6.692656] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 6.694531] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 6.696408] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 10.113646] systemd[1]: Starting Address configuration of eth1... worker # [ 6.698656] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 6.702464] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 6.704301] systemd[1]: Listening on udev Control Socket. worker # [ 6.705822] systemd[1]: Listening on udev Varlink Socket. worker # [ 6.709149] systemd[1]: Mounting Huge Pages File System... worker # [ 6.714520] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 10.131337] nsncd[597]: Jul 13 16:23:12.816 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 10.136700] systemd[1]: Starting Extra networking commands.... worker # [ 6.725204] systemd[1]: Mounting Kernel Debug File System... worker # [ 6.733197] systemd[1]: Mounting Kernel Trace File System... hub # [ 10.387726] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 10.152469] systemd[1]: Starting Tailscale node agent... hub # [ 10.160314] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 6.747203] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 10.166181] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 6.757217] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 10.176085] systemd[1]: Finished linger-users.service. worker # [ 6.775505] systemd[1]: Starting Load Kernel Module configfs... hub # [ 10.195830] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 6.780214] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 10.197508] systemd[1]: Reached target User and Group Name Lookups. worker # [ 6.783054] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.785703] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.793807] systemd[1]: Mounting FUSE Control File System... worker # [ 6.800221] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.809693] systemd[1]: Starting Journal Service... worker # [ 6.818198] systemd[1]: Starting Load Kernel Modules... hub # [ 10.472582] mousedev: PS/2 mouse device common for all mice worker # [ 6.827187] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 10.484138] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 6.845966] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 6.861272] loop: module loaded worker # [ 6.863227] systemd-journald[276]: Collecting audit messages is enabled. worker # [ 6.866228] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 10.523220] ACPI: button: Power Button [PWRF] hub # [ 10.289721] network-addresses-eth1-start[604]: adding address 192.168.1.1/24... done worker # [ 6.877442] systemd[1]: Starting Coldplug All udev Devices... hub # [ 10.539406] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 worker # [ 6.893112] EXT4-fs (vda): re-mounted cedbdfd1-d98a-4e8a-92c1-cb530c8f2a80. hub # [ 10.316241] network-addresses-eth1-start[604]: adding address 2001:db8:1::1/64... done worker # [ 6.910645] systemd[1]: Listening on Journal Log Access Socket. worker # [ 6.918595] systemd[1]: Mounted Huge Pages File System. worker # [ 6.681822] systemd[1]: Queued start job for default target Multi-User System. worker # [ 6.685730] systemd[1]: Unnecessary job was removed for /dev/vdb.[ 6.926348] systemd[1]: Started Journal Service. worker # worker # [ 6.691892] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 6.696706] systemd-modules-load[277]: Inserted module 'loop' worker # [ 6.700610] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 6.703570] systemd[1]: Mounted Kernel Debug File System. hub # [ 10.359706] systemd[1]: Finished Address configuration of eth1. worker # [ 6.708539] systemd[1]: Mounted Kernel Trace File System. worker # [ 6.713384] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 6.716708] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 6.721512] systemd[1]: Finished Load Kernel Module configfs. worker # [ 6.724497] systemd[1]: Mounted FUSE Control File System. worker # [ 6.727306] systemd[1]: Finished Load Kernel Modules. worker # [ 6.731294] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 6.743474] systemd-oomd[279]: No swap; memory pressure usage will be degraded worker # [ 6.748908] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 6.758154] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 6.762191] systemd[1]: Mounting Kernel Configuration File System... worker # [ 6.774102] systemd[1]: Starting Firewall... worker # [ 6.779099] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 6.780876] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 6.797200] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 6.814115] systemd[1]: Starting Apply Kernel Variables... hub # [ 10.484526] dhcpcd[632]: dhcpcd-10.3.2 starting worker # [ 6.833090] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 6.835552] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 10.496316] systemd[1]: Finished Extra networking commands.. hub # [ 10.502986] systemd[1]: Reached target Network. hub # [ 10.505572] dhcpcd[680]: dev: loaded udev hub # [ 10.516488] systemd[1]: Starting Nginx Web Server... worker # [ 7.109894] systemd-journald[276]: Received client request to flush runtime journal. hub # [ 10.528313] systemd[1]: Starting Permit User Sessions... hub # [ 10.628200] systemd[1]: Finished Permit User Sessions. hub # [ 10.659251] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD hub # [ 10.728053] tailscaled[616]: TPM: error opening: stat /dev/tpmrm0: no such file or directory hub # [ 10.710474] rtc_cmos 00:05: RTC can wake from S4 hub # [ 10.771908] parport_pc 00:03: reported by Plug and Play ACPI hub # [ 10.760924] tailscaled[616]: logtail started worker # [ 7.113755] systemd[1]: Mounted Kernel Configuration File System. hub # [ 10.765781] tailscaled[616]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} hub # [ 10.771269] tailscaled[616]: LogID: 0b9528fc7b0347eecf7b43e563d3079db4a67657ac2875a651ccdec467295cfc hub # [ 10.773440] tailscaled[616]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 7.121278] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 7.124749] systemd[1]: Reached target First Boot Complete. hub # [ 10.777188] tailscaled[616]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 10.782448] tailscaled[616]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 7.131142] systemd[1]: Finished Apply Kernel Variables. worker # [ 7.134493] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 7.137236] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 7.142257] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 7.143944] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 7.145742] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 7.149250] systemd[1]: Finished Flush Journal to Persistent Storage. worker # [ 7.151462] systemd-udevd[318]: Using default interface naming scheme 'v261'. hub # [ 10.829992] tailscaled[616]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:54438->[::1]:53: read: connection refused (in 17ms), trying bootstrap... hub # [ 10.772027] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 10.775986] rtc_cmos 00:05: registered as rtc0 hub # [ 10.859397] tailscaled[616]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ... hub # [ 10.865163] tailscaled[616]: bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 103.43.75.49:443: connect: network is unreachable hub # [ 10.870194] tailscaled[616]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ... worker # [ 7.219675] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 10.886858] tailscaled[616]: 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 hub # [ 10.892282] tailscaled[616]: trying bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" ... hub # [ 10.894675] tailscaled[616]: 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 # [ 10.899314] tailscaled[616]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ... hub # [ 10.907651] tailscaled[616]: 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 # [ 10.913085] tailscaled[616]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ... hub # [ 10.915442] tailscaled[616]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable hub # [ 10.919930] tailscaled[616]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... hub # [ 10.923107] tailscaled[616]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable worker # [ 7.273128] systemd[1]: Finished Coldplug All udev Devices. hub # [ 10.930182] tailscaled[616]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ... hub # [ 10.935673] tailscaled[616]: bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 46.101.74.201:443: connect: network is unreachable hub # [ 10.941692] tailscaled[616]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... hub # [ 10.945653] tailscaled[616]: 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 hub # [ 10.952392] tailscaled[616]: trying bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" ... hub # [ 10.955518] tailscaled[616]: bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 208.111.34.178:443: connect: network is unreachable hub # [ 10.961249] tailscaled[616]: trying bootstrapDNS("derp10.tailscale.com", "2001:19f0:8001:2d9:5400:2ff:feef:bbb1") for "log.tailscale.com" ... hub # [ 10.964919] tailscaled[616]: bootstrapDNS("derp10.tailscale.com", "2001:19f0:8001:2d9:5400:2ff:feef:bbb1") for "log.tailscale.com" error: Get "https://derp10.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:8001:2d9:5400:2ff:feef:bbb1]:443: connect: network is unreachable hub # [ 10.972167] tailscaled[616]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ... hub # [ 10.974908] tailscaled[616]: 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 hub # [ 10.979628] tailscaled[616]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... hub # [ 10.983192] tailscaled[616]: 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 # [ 10.989147] tailscaled[616]: logtail: upload: log upload of 477 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/b02e84487a293d02e7c0cafa8ee69f39e3caa868627955128356506cf3e55a63": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" hub # [ 10.776141] rtc_cmos 00:05: setting system clock to 2026-07-13T16:23:13 UTC (1783959793) hub # [ 10.776285] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 10.786116] 8021q: 802.1Q VLAN Support v1.8 hub # [ 10.786131] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 7.410300] systemd[1]: Mounting /run/wrappers... hub # [ 11.063970] nginx-pre-start[692]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok hub # [ 11.069451] nginx-pre-start[692]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful hub # [ 10.813390] Floppy drive(s): fd0 is 2.88M AMI BIOS hub # [ 10.838509] FDC 0 is a S82078B hub # [ 10.923553] Console: switching to colour dummy device 80x25 worker # [ 7.443180] systemd[1]: Mounted /run/wrappers. hub # [ 11.098130] dhcpcd[680]: eth0: waiting for carrier hub # [ 11.100332] dhcpcd[680]: libudev: received NULL device hub # [ 11.101707] dhcpcd[680]: libudev: received NULL device worker # [ 7.448277] systemd[1]: Reached target Local File Systems. hub # [ 11.103901] dhcpcd[680]: eth0: carrier acquired worker # [ 7.449820] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 7.458114] systemd[1]: Starting register-nix-paths.service... hub # [ 11.117932] dhcpcd[680]: DUID 00:01:00:01:31:e7:cd:72:52:54:00:12:34:56 worker # [ 7.465657] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 11.120446] dhcpcd[680]: eth0: IAID 00:12:34:56 hub # [ 11.122200] dhcpcd[680]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 7.467609] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 11.082639] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 11.146231] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 worker # [ 7.484266] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 7.502115] systemd[1]: Starting Create System Files and Directories... hub # [ 11.168104] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 11.168222] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 11.173022] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 11.173031] cfg80211: failed to load regulatory.db worker # [ 7.531118] systemd[1]: Finished Firewall. hub # [ 11.319377] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 11.319814] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 7.576970] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 7.586598] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 11.241445] systemd-logind[539]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 11.248810] systemd-logind[539]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) hub # [ 11.334177] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 11.496338] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 11.496341] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 11.261430] systemd[1]: Started Getty on tty1. hub # [ 11.263105] systemd[1]: Reached target Login Prompts. hub # [ 11.270211] systemd[1]: Started Nginx Web Server. hub # [ 11.510139] ppdev: user-space parallel port driver hub # [ 11.516886] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic hub # [ 11.518226] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 7.626120] systemd[1]: Finished Create System Files and Directories. worker # [ 7.640241] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 11.292624] dbus-broker-launch[517]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 7.651117] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 7.652883] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 11.332132] systemd[1]: Starting Virtual Console Setup... hub # [ 11.357784] tailscaled[616]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 11.362425] tailscaled[616]: dns: using "openresolv" mode hub # [ 11.374316] tailscaled[616]: dns: using dns.openresolvManager worker # [ 7.738315] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 7.780663] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.796799] systemd[1]: Starting Update is Completed... hub # [ 11.665492] fbcon: bochs-drmdrmfb (fb0) is primary device hub # [ 11.697696] Console: switching to colour frame buffer device 160x50 hub # [ 11.731402] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 7.849857] systemd[1]: Finished Update is Completed. hub # [ 11.834673] kvm_amd: TSC scaling supported hub # [ 11.835604] kvm_amd: Nested Virtualization enabled worker # [ 7.943859] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 11.838021] kvm_amd: Nested Paging enabled hub # [ 11.839584] kvm_amd: LBR virtualization supported hub # [ 11.841508] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 7.949669] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 11.843344] kvm_amd: Virtual GIF supported hub # [ 11.844653] kvm_amd: Virtual NMI enabled worker # [ 7.954722] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 8.023511] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 11.688249] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 8.049313] (udev-worker)[391]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 8.055107] (udev-worker)[391]: Network interface NamePolicy= disabled on kernel command line. worker # [ 8.060233] (udev-worker)[389]: Network interface NamePolicy= disabled on kernel command line. hub # [ 11.980418] EDAC MC: Ver: 3.0.0 worker # [ 8.117280] systemd[1]: Finished register-nix-paths.service. hub # [ 11.772541] systemd[1]: Started Tailscale node agent. worker # [ 8.120305] systemd[1]: Reached target System Initialization. hub # [ 11.776344] tailscaled[616]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 8.125341] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 8.127254] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 8.130262] systemd[1]: Reached target Timer Units. worker # [ 8.132477] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 8.135223] systemd[1]: Listening on Nix Daemon Socket. worker # [ 8.136681] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 8.139758] systemd[1]: Listening on tribuchet-sandboxd.socket. worker # [ 8.142092] systemd[1]: Reached target Socket Units. worker # [ 8.144220] systemd[1]: Reached target Basic System. worker # [ 8.146665] systemd[1]: Started backdoor.service. hub # [ 12.040458] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.155280] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 8.165108] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 8.179895] systemd[1]: Starting Post-Boot Actions... worker # [ 8.194630] systemd[1]: Started Reset console on configuration changes. hub # [ 11.856270] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 11.859415] systemd[1]: Stopped Virtual Console Setup. worker # connecting to host... worker # [ 8.215877] systemd[1]: Starting resolvconf update... hub # [ 11.873697] systemd[1]: Starting Virtual Console Setup... hub # [ 11.884392] (udev-worker)[748]: Network interface NamePolicy= disabled on kernel command line. hub # [ 11.892379] tailscaled[616]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 11.894291] tailscaled[616]: dns: using "openresolv" mode worker # [ 8.258135] systemd[1]: Finished Post-Boot Actions. hub # [ 11.916634] tailscaled[616]: dns: using dns.openresolvManager hub # [ 11.919661] tailscaled[616]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} hub # [ 11.933095] tailscaled[616]: magicsock: disco key = d:2df808ea2a7653c2 worker # [ 8.279180] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 8.281872] nsncd[503]: Jul 13 16:23:14.625 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 11.937813] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) hub # [ 11.942830] tailscaled[616]: Creating WireGuard device... worker # [ 8.294143] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 11.950173] tailscaled[616]: Bringing WireGuard device up... hub # [ 11.954146] tailscaled[616]: router: portUpdate(port=41641, network=udp6) hub # [ 11.956772] tailscaled[616]: router: using firewall mode pref worker # [ 8.303138] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 8.308112] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 8.309794] systemd[1]: Reached target User and Group Name Lookups. worker # [ 8.318294] systemd[1]: Starting D-Bus System Message Bus... hub # [ 11.974573] tailscaled[616]: external route: up hub # [ 11.977225] tailscaled[616]: Bringing router up... worker # [ 8.339827] systemd[1]: Starting User Login Management... hub # [ 12.012168] tailscaled[616]: router: default choosing iptables hub # [ 12.053661] tailscaled[616]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 12.056273] tailscaled[616]: router: portUpdate(port=41641, network=udp4) worker # [ 8.407309] dbus-broker-launch[529]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 12.062548] tailscaled[616]: Clearing router settings... hub # [ 12.063976] tailscaled[616]: Starting network monitor... worker # [ 8.411456] dbus-broker-launch[529]: NSS returned no entry for 'systemd-timesync' worker # [ 8.415111] dbus-broker-launch[529]: Invalid user-name in /nix/store/a7agjv2209jvj4cvwy8lz4g35l9gak1c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" hub # [ 12.073194] tailscaled[616]: Engine created. hub # [ 12.084672] tailscaled[616]: pm: migrating "_daemon" profile to new format worker # [ 8.430835] systemd[1]: Started D-Bus System Message Bus. hub # [ 12.087282] tailscaled[616]: envknob: PORT="41641" hub # [ 12.093904] tailscaled[616]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 12.097435] tailscaled[616]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 12.102288] tailscaled[616]: got LocalBackend in 328ms hub # [ 12.103921] tailscaled[616]: Start hub # [ 12.104895] tailscaled[616]: ipnext: "conn25": skipping extension hub # [ 12.106910] tailscaled[616]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop hub # [ 12.114772] tailscaled[616]: profile data directory: profile not found worker # [ 8.461476] dbus-broker-launch[529]: Ready hub # [ 12.118108] tailscaled[616]: Backend: logs: be:0b9528fc7b0347eecf7b43e563d3079db4a67657ac2875a651ccdec467295cfc fe: hub # [ 12.121119] tailscaled[616]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 12.123592] tailscaled[616]: blockEngineUpdates(true) hub # [ 12.126546] tailscaled[616]: wgengine: Reconfig: configuring router hub # [ 12.128530] tailscaled[616]: wgengine: Reconfig: user dialer hub # [ 12.130260] tailscaled[616]: wgengine: Reconfig: configuring DNS hub # [ 12.131979] tailscaled[616]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 12.134377] tailscaled[616]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 12.137607] tailscaled[616]: dns: OScfg: {} worker # [ 8.483931] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 8.485642] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 8.488522] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 8.492428] systemd[1]: Stopping User and Group Name Lookups... worker # [ 8.495282] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 8.498209] systemd[1]: nscd.service: Deactivated successfully. worker # [ 8.502235] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 12.157937] tailscaled[616]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 8.505948] systemd[1]: nscd.service: Consumed 17ms CPU time over 333ms wall clock time, 6.8M memory peak, 5.5M read from disk. worker # [ 8.514354] systemd-logind[533]: New seat seat0. worker # [ 8.519697] systemd[1]: Started User Login Management. worker # [ 8.531213] systemd[1]: Starting linger-users.service... worker # [ 8.543104] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 8.573099] systemd[1]: Finished resolvconf update. worker # [ 8.583313] systemd[1]: Reached target Preparation for Network. worker # [ 8.593160] systemd[1]: Starting DHCP Client... hub # [ 12.249163] dhcpcd[680]: eth0: soliciting a DHCP lease worker # [ 8.602115] systemd[1]: Starting Address configuration of eth1... worker # [ 8.607685] nsncd[580]: Jul 13 16:23:14.951 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 12.507019] NET: Registered PF_PACKET protocol family hub # [ 12.272652] dhcpcd[680]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 8.618699] systemd[1]: Starting Extra networking commands.... hub # [ 12.275237] dhcpcd[680]: eth0: probing address 10.0.2.15/24 worker # [ 8.632662] systemd[1]: Starting Tailscale node agent... worker # [ 8.641379] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 8.649106] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 8.657258] systemd[1]: Finished linger-users.service. worker # [ 8.674593] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 8.676304] systemd[1]: Reached target User and Group Name Lookups. hub # [ 12.350603] systemd-vconsole-setup[772]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 12.357182] systemd[1]: Finished Virtual Console Setup. worker # [ 8.949248] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 8.719438] network-addresses-eth1-start[588]: adding address 192.168.1.2/24... done worker # [ 8.736111] network-addresses-eth1-start[588]: adding address 2001:db8:1::2/64... done worker # [ 8.755264] systemd[1]: Finished Address configuration of eth1. worker # [ 9.100350] mousedev: PS/2 mouse device common for all mice worker # [ 9.107680] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 8.930167] dhcpcd[621]: dhcpcd-10.3.2 starting worker # [ 8.933276] systemd[1]: Finished Extra networking commands.. worker # [ 8.939210] systemd[1]: Reached target Network. worker # [ 8.945217] dhcpcd[665]: dev: loaded udev worker # [ 8.948559] systemd[1]: Starting Permit User Sessions... worker # [ 8.979327] tailscaled[600]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 9.002901] tailscaled[600]: logtail started worker # [ 9.004158] tailscaled[600]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} worker # [ 9.009328] tailscaled[600]: LogID: f94c0242dc471f06bba7d1b2f58267813d9330ee56bae1f09c6322b4c60f19d0 worker # [ 9.011766] tailscaled[600]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 9.014911] tailscaled[600]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 9.020268] tailscaled[600]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 9.022635] systemd[1]: Finished Permit User Sessions. worker # [ 9.041105] tailscaled[600]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:41637->[::1]:53: read: connection refused (in 11ms), trying bootstrap... worker # [ 9.061935] tailscaled[600]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ... worker # [ 9.064353] tailscaled[600]: 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 hub # [ 12.723262] dhcpcd[680]: eth0: soliciting an IPv6 router worker # [ 9.068854] tailscaled[600]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... hub # [ 12.725615] dhcpcd[680]: eth0: Router Advertisement from fe80::2 hub # [ 12.727298] dhcpcd[680]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 9.071416] tailscaled[600]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable hub # [ 12.729624] dhcpcd[680]: eth0: adding route to fec0::/64 hub # [ 12.731429] tailscaled[616]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 9.077156] tailscaled[600]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ... hub # [ 12.733486] tailscaled[616]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 12.735509] dhcpcd[680]: eth0: adding default route via fe80::2 worker # [ 9.079543] tailscaled[600]: 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 # [ 9.084145] tailscaled[600]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... worker # [ 9.090108] tailscaled[600]: 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 worker # [ 9.095459] tailscaled[600]: trying bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" ... worker # [ 9.097856] tailscaled[600]: 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 worker # [ 9.102391] tailscaled[600]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... worker # [ 9.107919] tailscaled[600]: 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 # [ 9.113250] tailscaled[600]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ... worker # [ 9.115609] tailscaled[600]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable worker # [ 9.122141] tailscaled[600]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... worker # [ 9.124967] tailscaled[600]: bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:1d9c:5400:2ff:feef:bb82]:443: connect: network is unreachable worker # [ 9.130342] tailscaled[600]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ... worker # [ 9.132806] tailscaled[600]: 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 # [ 9.139136] tailscaled[600]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... worker # [ 9.141919] tailscaled[600]: 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 # [ 9.148135] tailscaled[600]: trying bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" ... worker # [ 9.152323] tailscaled[600]: bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.77.138:443: connect: network is unreachable worker # [ 9.156902] tailscaled[600]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... worker # [ 9.160227] tailscaled[600]: 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 worker # [ 9.165570] tailscaled[600]: logtail: upload: log upload of 477 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/10641db50576e1690971b0b82c996115db1d827df50cf243cf6a11adb3020b7c": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 9.135199] ACPI: button: Power Button [PWRF] worker # [ 9.145550] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 worker # [ 9.145614] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 9.201367] 8021q: 802.1Q VLAN Support v1.8 worker # [ 9.290805] dhcpcd[665]: eth0: waiting for carrier worker # [ 9.292532] dhcpcd[665]: eth0: carrier acquired worker # [ 9.201383] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 9.222431] rtc_cmos 00:05: RTC can wake from S4 worker # [ 9.417202] rtc_cmos 00:05: registered as rtc0 worker # [ 9.300564] dhcpcd[665]: DUID 00:01:00:01:31:e7:cd:73:52:54:00:12:34:56 worker # [ 9.302254] dhcpcd[665]: eth0: IAID 00:12:34:56 worker # [ 9.304214] dhcpcd[665]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 9.417328] rtc_cmos 00:05: setting system clock to 2026-07-13T16:23:15 UTC (1783959795) worker # [ 9.417487] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 9.427578] parport_pc 00:03: reported by Plug and Play ACPI worker # [ 9.427702] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 9.447547] Floppy drive(s): fd0 is 2.88M AMI BIOS worker # [ 9.463419] Console: switching to colour dummy device 80x25 worker # [ 9.465369] FDC 0 is a S82078B worker # [ 9.490600] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 9.494425] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 9.494544] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 9.494712] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 13.075729] tailscaled[616]: 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::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/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::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed] hub # [ 13.085977] tailscaled[616]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 13.088583] tailscaled[616]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 13.090347] tailscaled[616]: dns: OScfg: {} worker # [ 9.494720] cfg80211: failed to load regulatory.db worker # [ 9.528458] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 9.586977] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 hub # [ 13.132145] tailscaled[616]: wgengine: set DNS config again after major link change hub # [ 13.135118] tailscaled[616]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/64] hub # [ 13.139078] tailscaled[616]: magicsock: 0 active derp conns hub # [ 13.140444] tailscaled[616]: router: portUpdate(port=41641, network=udp6) hub # [ 13.142118] tailscaled[616]: router: portUpdate(port=41641, network=udp4) worker # [ 9.488701] systemd-logind[533]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 9.623660] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 9.624078] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 9.505135] systemd-logind[533]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 9.528262] systemd[1]: Started Getty on tty1. worker # [ 9.530257] systemd[1]: Reached target Login Prompts. worker # [ 9.770662] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 9.776350] ppdev: user-space parallel port driver worker # [ 9.545182] dbus-broker-launch[529]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 9.566156] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 9.573260] tailscaled[600]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 9.577167] tailscaled[600]: dns: using "openresolv" mode worker # [ 9.578535] tailscaled[600]: dns: using dns.openresolvManager worker # [ 9.581398] systemd[1]: Starting Virtual Console Setup... worker # [ 9.826407] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 9.874727] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic worker # [ 9.908132] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 9.694432] systemd-vconsole-setup[688]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.703404] systemd[1]: Finished Virtual Console Setup. worker # [ 9.757118] tailscaled[600]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 9.759427] systemd[1]: Started Tailscale node agent. worker # [ 9.766817] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 10.009985] tun: Universal TUN/TAP device driver, 1.6 worker # [ 9.807530] tailscaled[600]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 9.809643] tailscaled[600]: dns: using "openresolv" mode worker # [ 9.819097] tailscaled[600]: dns: using dns.openresolvManager worker # [ 9.820626] tailscaled[600]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 9.823314] tailscaled[600]: magicsock: disco key = d:e7c2333878e7b8bb worker # [ 9.827472] tailscaled[600]: Creating WireGuard device... worker # [ 9.829049] tailscaled[600]: Bringing WireGuard device up... worker # [ 9.835101] tailscaled[600]: Bringing router up... worker # [ 9.836353] tailscaled[600]: router: using firewall mode pref worker # [ 9.838088] tailscaled[600]: router: portUpdate(port=41641, network=udp6) worker # [ 9.842654] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.846856] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.848277] systemd[1]: Stopping Virtual Console Setup... worker # [ 10.012120] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 9.854092] tailscaled[600]: external route: up worker # [ 9.860181] systemd[1]: Starting Virtual Console Setup... worker # [ 10.089344] Console: switching to colour frame buffer device 160x50 worker # [ 10.122093] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 9.886886] tailscaled[600]: router: default choosing iptables worker # [ 9.924078] tailscaled[600]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 9.929305] tailscaled[600]: router: portUpdate(port=41641, network=udp4) worker # [ 9.930946] tailscaled[600]: Clearing router settings... worker # [ 9.932476] tailscaled[600]: Starting network monitor... worker # [ 9.933830] tailscaled[600]: Engine created. worker # [ 9.944636] systemd-vconsole-setup[725]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.951374] tailscaled[600]: pm: migrating "_daemon" profile to new format worker # [ 9.956173] tailscaled[600]: envknob: PORT="41641" worker # [ 9.957420] tailscaled[600]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 9.959251] tailscaled[600]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 9.963164] tailscaled[600]: got LocalBackend in 206ms worker # [ 9.964750] tailscaled[600]: Start worker # [ 9.967476] tailscaled[600]: ipnext: "conn25": skipping extension worker # [ 9.969252] tailscaled[600]: ipnext: active extensions: portlist, posture, clientupdate, relayserver, taildrop, conn25 worker # [ 9.974448] systemd[1]: Finished Virtual Console Setup. worker # [ 9.979455] tailscaled[600]: profile data directory: profile not found worker # [ 9.982276] tailscaled[600]: Backend: logs: be:f94c0242dc471f06bba7d1b2f58267813d9330ee56bae1f09c6322b4c60f19d0 fe: worker # [ 9.988184] tailscaled[600]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 9.990306] tailscaled[600]: blockEngineUpdates(true) worker # [ 9.991582] tailscaled[600]: wgengine: Reconfig: configuring router worker # [ 9.993190] tailscaled[600]: wgengine: Reconfig: user dialer worker # [ 9.995128] tailscaled[600]: wgengine: Reconfig: configuring DNS worker # [ 9.996632] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 9.998608] tailscaled[600]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 10.001134] tailscaled[600]: dns: OScfg: {} worker # [ 10.004909] tailscaled[600]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 10.016302] dhcpcd[665]: eth0: soliciting a DHCP lease worker # [ 10.279247] NET: Registered PF_PACKET protocol family worker # [ 10.044487] dhcpcd[665]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 10.046269] dhcpcd[665]: eth0: probing address 10.0.2.15/24 worker # [ 10.306124] kvm_amd: TSC scaling supported worker # [ 10.306878] kvm_amd: Nested Virtualization enabled worker # [ 10.308091] kvm_amd: Nested Paging enabled worker # [ 10.308831] kvm_amd: LBR virtualization supported worker # [ 10.310001] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 10.311127] kvm_amd: Virtual GIF supported worker # [ 10.311851] kvm_amd: Virtual NMI enabled worker # [ 10.342670] EDAC MC: Ver: 3.0.0 hub # [ 13.816252] tailscaled[616]: monitor: RTM_NEWROUTE: src=, dst=fec0::1401:8dda:5c9b:6681/128, gw=, outif=2, table=255 hub # [ 13.878801] tailscaled[616]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 11.292746] dhcpcd[665]: eth0: soliciting an IPv6 router worker # [ 11.298914] dhcpcd[665]: eth0: Router Advertisement from fe80::2 worker # [ 11.304925] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 11.312321] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 11.317519] dhcpcd[665]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 11.322610] dhcpcd[665]: eth0: adding route to fec0::/64 worker # [ 11.328553] dhcpcd[665]: eth0: adding default route via fe80::2 worker # [ 11.333896] tailscaled[600]: 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::2ee1:148f:2f89:d875/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::2ee1:148f:2f89:d875/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed] worker # [ 11.356194] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 11.360685] tailscaled[600]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 11.364326] tailscaled[600]: dns: OScfg: {} worker # [ 11.378602] tailscaled[600]: wgengine: set DNS config again after major link change worker # [ 11.381806] tailscaled[600]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::2ee1:148f:2f89:d875/64 fec0::5054:ff:fe12:3456/64] worker # [ 11.384881] tailscaled[600]: magicsock: 0 active derp conns worker # [ 11.387124] tailscaled[600]: router: portUpdate(port=41641, network=udp6) worker # [ 11.388919] tailscaled[600]: router: portUpdate(port=41641, network=udp4) worker # [ 12.600556] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 12.918269] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=fec0::2ee1:148f:2f89:d875/128, gw=, outif=2, table=255 hub # [ 17.452092] dhcpcd[680]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 17.455894] dhcpcd[680]: eth0: adding route to 10.0.2.0/24 hub # [ 17.458413] tailscaled[616]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 17.460649] tailscaled[616]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 17.465872] tailscaled[616]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 17.468119] tailscaled[616]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 17.470321] dhcpcd[680]: eth0: adding default route via 10.0.2.2 hub # [ 17.477120] tailscaled[616]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/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::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/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::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed] hub # [ 17.502071] tailscaled[616]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 17.504190] tailscaled[616]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 17.506553] tailscaled[616]: dns: OScfg: {} hub # [ 17.600418] systemd[1]: Started DHCP Client. hub # [ 17.603936] systemd[1]: Reached target Network is Online. hub # [ 17.609628] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 17.612267] systemd[1]: Reached target Multi-User System. hub # [ 17.614455] systemd[1]: Startup finished in 996ms (kernel) + 4.377s (initrd) + 12.239s (userspace) = 17.613s. hub: (finished: waiting for unit headscale, in 15.21 seconds) hub: waiting for TCP port 443 on localhost hub # [ 18.020468] headscale-start[894]: 2026-07-13T16:23:20Z WRN hub # [ 18.022196] headscale-start[894]: 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 # [ 18.029194] headscale-start[894]: 2026-07-13T16:23:20Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 18.033589] headscale-start[894]: 2026-07-13T16:23:20Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.09 seconds) hub: waiting for unit tailscaled hub: (finished: waiting for unit tailscaled, in 0.08 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) hub # [ 18.142145] headscale-start[894]: 2026-07-13T16:23:21Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 18.151562] headscale-start[894]: 2026-07-13T16:23:21Z INF starting headscale commit=v0.29.2 version=0.29.2 hub # [ 18.154091] headscale-start[894]: 2026-07-13T16:23:21Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 18.157424] headscale-start[894]: 2026-07-13T16:23:21Z 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:[0x22f929a48120]} hub # [ 18.162424] headscale-start[894]: 2026-07-13T16:23:21Z 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 # [ 18.174872] headscale-start[894]: 2026-07-13T16:23:21Z INF stun server started at [::]:3478 worker: (finished: waiting for unit tailscaled, in 0.04 seconds) hub: must succeed: headscale users create test hub # [ 18.178078] headscale-start[894]: 2026-07-13T16:23:21Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 18.189211] headscale-start[894]: 2026-07-13T16:23:21Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 18.199764] headscale-start[894]: 2026-07-13T16:23:21Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 18.202651] headscale-start[894]: 2026-07-13T16:23:21Z INF metrics server disabled (metrics_listen_addr is empty) hub # [ 18.274535] headscale-start[894]: 2026-07-13T16:23:21Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 0.10 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-tKnEMWwel-RT-vwjqIWljBvGoG_hqY1qOxp80Mgrf6PfYQXep8SYOkYmpYxTDYVej0ScAeRwCEdoO --hostname hub hub # [ 18.474534] tailscaled[616]: localapi: [POST] /localapi/v0/check-prefs hub # [ 18.477751] tailscaled[616]: localapi: [POST] /localapi/v0/start hub # [ 18.479881] tailscaled[616]: Start hub # [ 18.481213] tailscaled[616]: 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.485936] tailscaled[616]: generating new machine key hub # [ 18.491199] tailscaled[616]: machine key written to store hub # [ 18.492842] tailscaled[616]: profile data directory: profile not found hub # [ 18.496444] tailscaled[616]: Backend: logs: be:0b9528fc7b0347eecf7b43e563d3079db4a67657ac2875a651ccdec467295cfc fe: hub # [ 18.505935] tailscaled[616]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 18.508286] tailscaled[616]: blockEngineUpdates(true) hub # [ 18.509564] tailscaled[616]: Reconfig(down): no changes made to Engine config hub # [ 18.513390] tailscaled[616]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 18.515492] tailscaled[616]: health(warnable=wantrunning-false): ok hub # [ 18.517100] tailscaled[616]: control: client.Shutdown ... hub # [ 18.518433] tailscaled[616]: control: mapRoutine: exiting hub # [ 18.519784] tailscaled[616]: control: authRoutine: exiting hub # [ 18.521336] tailscaled[616]: control: updateRoutine: exiting hub # [ 18.523223] tailscaled[616]: control: Client.Shutdown done. hub # [ 18.525293] tailscaled[616]: localapi: [POST] /localapi/v0/login-interactive hub # [ 18.528180] tailscaled[616]: StartLoginInteractiveAs("root"): url=false hub # [ 18.529755] tailscaled[616]: control: client.Login(2) hub # [ 18.532303] tailscaled[616]: control: LoginInteractive -> regen=true hub # [ 18.534142] tailscaled[616]: control: doLogin(regen=true, hasUrl=false) hub # [ 18.570703] tailscaled[616]: wgengine: set DNS config again after major link change hub # [ 18.573316] tailscaled[616]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1401:8dda:5c9b:6681/64 fec0::5054:ff:fe12:3456/64] hub # [ 18.576568] tailscaled[616]: magicsock: 0 active derp conns hub # [ 18.581338] tailscaled[616]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 18.584231] tailscaled[616]: router: portUpdate(port=41641, network=udp6) hub # [ 18.586284] tailscaled[616]: router: portUpdate(port=41641, network=udp4) hub # [ 18.588213] tailscaled[616]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 18.634126] tailscaled[616]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 18.652836] headscale-start[894]: 2026-07-13T16:23:21Z INF http request bytes=176 elapsed=3.290921 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:58940 status=200 hub # [ 18.661213] tailscaled[616]: control: control server key from https://hub: ts2021=[PhC5l], legacy= hub # [ 18.664387] tailscaled[616]: control: Generating a new nodekey. hub # [ 18.668866] tailscaled[616]: control: RegisterReq: onode= node=[NRCQh] fup=false nks=false worker # [ 15.052778] dhcpcd[665]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 15.060789] dhcpcd[665]: eth0: adding route to 10.0.2.0/24 worker # [ 15.065659] dhcpcd[665]: eth0: adding default route via 10.0.2.2 worker # [ 15.078858] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 15.087607] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 15.094414] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 15.110200] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 15.114508] tailscaled[600]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::2ee1:148f:2f89:d875/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::2ee1:148f:2f89:d875/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::2ee1:148f:2f89:d875/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::2ee1:148f:2f89:d875/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed] worker # [ 15.135462] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 15.139167] tailscaled[600]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 15.140928] tailscaled[600]: dns: OScfg: {} worker # [ 15.191651] systemd[1]: Started DHCP Client. worker # [ 15.195528] systemd[1]: Reached target Multi-User System. worker # [ 15.197298] systemd[1]: Startup finished in 981ms (kernel) + 4.445s (initrd) + 9.769s (userspace) = 15.197s. hub # [ 19.664576] headscale-start[894]: 2026-07-13T16:23:22Z INF http request bytes=249 elapsed=971.772111 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:58954 status=200 hub # [ 19.677671] tailscaled[616]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 19.698195] tailscaled[616]: blockEngineUpdates(false) worker # [ 16.178688] tailscaled[600]: wgengine: set DNS config again after major link change worker # [ 16.185400] tailscaled[600]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::2ee1:148f:2f89:d875/64 fec0::5054:ff:fe12:3456/64] worker # [ 16.195376] tailscaled[600]: router: portUpdate(port=41641, network=udp6) worker # [ 16.199384] tailscaled[600]: router: portUpdate(port=41641, network=udp4) worker # [ 16.203504] tailscaled[600]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") worker # [ 16.210222] tailscaled[600]: magicsock: 0 active derp conns worker # [ 16.213748] tailscaled[600]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 20.171515] headscale-start[894]: 2026-07-13T16:23:23Z INF http request bytes=0 elapsed=460.718053 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58954 status=200 hub # [ 20.670904] headscale-start[894]: 2026-07-13T16:23:23Z INF node connected machine.key=[V9wEe] node.expired=false node.id=1 node.is_tagged=false node.key=[NRCQh] node.name=hub node.online=true user.name=test hub # [ 20.675240] headscale-start[894]: 2026-07-13T16:23:23Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x22f9299ac7e0 component=poll machine.key=[V9wEe] node.expired=false node.id=1 node.is_tagged=false node.key=[NRCQh] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 20.704335] tailscaled[616]: health(warnable=not-in-map-poll): ok hub # [ 20.724067] tailscaled[616]: active login: test hub # [ 20.735254] tailscaled[616]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 20.737903] tailscaled[616]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 20.741344] tailscaled[616]: magicsock: SetPrivateKey called (init) hub # [ 20.743205] tailscaled[616]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers) hub # [ 20.749619] tailscaled[616]: wgengine: Reconfig: configuring router hub # [ 20.985144] tailscaled[616]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [15ms] (forced=false) hub # [ 20.987485] tailscaled[616]: magicsock: home is now derp-999 () hub # [ 20.990274] tailscaled[616]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 20.994954] tailscaled[616]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 20.997581] tailscaled[616]: 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::1401:8dda:5c9b:6681]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local) hub # [ 21.002938] tailscaled[616]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 21.010097] tailscaled[616]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 21.025227] tailscaled[616]: magicsock: derp-999 connected; connGen=1 hub # [ 21.236939] tailscaled[616]: router: enabling connmark-based rp_filter workaround hub # [ 21.327412] tailscaled[616]: wgengine: Reconfig: user dialer hub # [ 21.329971] tailscaled[616]: tsdial: bart table size: 2 hub # [ 21.331327] tailscaled[616]: wgengine: Reconfig: configuring DNS hub # [ 21.332787] tailscaled[616]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1} hub # [ 21.381111] tailscaled[616]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa} hub # [ 21.383588] tailscaled[616]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 21.461439] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 21.463192] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 21.466638] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 21.469163] systemd[1]: Stopping User and Group Name Lookups... hub # [ 21.470721] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 21.473565] systemd[1]: nscd.service: Deactivated successfully. hub # [ 21.475656] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 21.489620] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 21.518957] tailscaled[616]: peerapi: serving on http://100.64.0.1:58436 hub # [ 21.522109] tailscaled[616]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 21.527693] tailscaled[616]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 21.533642] tailscaled[616]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 21.537875] nsncd[1039]: Jul 13 16:23:24.500 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 21.543180] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 21.545499] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 21.548808] systemd[1]: Reached target User and Group Name Lookups. hub # [ 21.551670] tailscaled[616]: netmap: suggested exit node: () hub # [ 21.553262] tailscaled[616]: writing netmap to disk cache hub # [ 21.556488] tailscaled[616]: health(warnable=no-derp-connection): ok hub # [ 21.558199] tailscaled[616]: health(warnable=no-derp-connection): ok hub # [ 21.560684] tailscaled[616]: health(warnable=warming-up): ok hub # [ 21.562622] tailscaled[616]: [RATELIMIT] format("health(warnable=%s): ok") hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-tKnEMWwel-RT-vwjqIWljBvGoG_hqY1qOxp80Mgrf6PfYQXep8SYOkYmpYxTDYVej0ScAeRwCEdoO --hostname hub, in 3.16 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-tKnEMWwel-RT-vwjqIWljBvGoG_hqY1qOxp80Mgrf6PfYQXep8SYOkYmpYxTDYVej0ScAeRwCEdoO --hostname tt-worker worker # [ 17.967499] tailscaled[600]: localapi: [POST] /localapi/v0/check-prefs worker # [ 17.969813] tailscaled[600]: localapi: [POST] /localapi/v0/start worker # [ 17.971788] tailscaled[600]: Start worker # [ 17.973250] tailscaled[600]: 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 # [ 17.977605] tailscaled[600]: generating new machine key worker # [ 17.982511] tailscaled[600]: machine key written to store worker # [ 17.984243] tailscaled[600]: profile data directory: profile not found worker # [ 17.986292] tailscaled[600]: Backend: logs: be:f94c0242dc471f06bba7d1b2f58267813d9330ee56bae1f09c6322b4c60f19d0 fe: worker # [ 17.989119] tailscaled[600]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 17.992202] tailscaled[600]: blockEngineUpdates(true) worker # [ 17.994794] tailscaled[600]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 17.996822] tailscaled[600]: Reconfig(down): no changes made to Engine config worker # [ 17.999095] tailscaled[600]: health(warnable=wantrunning-false): ok worker # [ 18.000603] tailscaled[600]: control: client.Shutdown ... worker # [ 18.002208] tailscaled[600]: control: updateRoutine: exiting worker # [ 18.004209] tailscaled[600]: control: authRoutine: exiting worker # [ 18.005947] tailscaled[600]: control: mapRoutine: exiting worker # [ 18.007754] tailscaled[600]: control: Client.Shutdown done. worker # [ 18.009662] tailscaled[600]: localapi: [POST] /localapi/v0/login-interactive worker # [ 18.011559] tailscaled[600]: StartLoginInteractiveAs("root"): url=false worker # [ 18.013450] tailscaled[600]: control: client.Login(2) worker # [ 18.016442] tailscaled[600]: control: LoginInteractive -> regen=true worker # [ 18.018125] tailscaled[600]: control: doLogin(regen=true, hasUrl=false) hub # [ 21.672164] headscale-start[894]: 2026-07-13T16:23:24Z INF http request bytes=0 elapsed=124.134492 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58954 status=200 worker # [ 18.042702] tailscaled[600]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 21.698118] headscale-start[894]: 2026-07-13T16:23:24Z INF http request bytes=176 elapsed=0.094146 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:58966 status=200 worker # [ 18.047672] tailscaled[600]: control: control server key from https://hub: ts2021=[PhC5l], legacy= worker # [ 18.050199] tailscaled[600]: control: Generating a new nodekey. worker # [ 18.054423] tailscaled[600]: control: RegisterReq: onode= node=[YvaZW] fup=false nks=false hub # [ 22.165764] tailscaled[616]: netmap: suggested exit node: () hub # [ 22.677996] headscale-start[894]: 2026-07-13T16:23:25Z INF http request bytes=249 elapsed=959.289518 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:58976 status=200 worker # [ 19.027962] tailscaled[600]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 19.041561] tailscaled[600]: blockEngineUpdates(false) hub # [ 22.962784] tailscaled[616]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 22.975830] tailscaled[616]: netmap: suggested exit node: () hub # [ 22.983237] tailscaled[616]: wgengine: Reconfig: user dialer hub # [ 22.986622] tailscaled[616]: tsdial: bart table size: 2 hub # [ 22.990928] tailscaled[616]: wgengine: Reconfig: configuring DNS hub # [ 22.995855] tailscaled[616]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} hub # [ 23.062567] tailscaled[616]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} hub # [ 23.065572] tailscaled[616]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 23.175361] headscale-start[894]: 2026-07-13T16:23:26Z INF http request bytes=0 elapsed=479.443896 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58976 status=200 hub # [ 23.675408] headscale-start[894]: 2026-07-13T16:23:26Z INF node connected machine.key=[ngFUX] node.expired=false node.id=2 node.is_tagged=false node.key=[YvaZW] node.name=tt-worker node.online=true user.name=test hub # [ 23.687895] headscale-start[894]: 2026-07-13T16:23:26Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x22f929bc7e30 component=poll machine.key=[ngFUX] node.expired=false node.id=2 node.is_tagged=false node.key=[YvaZW] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test worker # [ 20.072660] tailscaled[600]: health(warnable=not-in-map-poll): ok worker # [ 20.090873] tailscaled[600]: active login: test worker # [ 20.106237] tailscaled[600]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 20.110278] tailscaled[600]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 20.121221] tailscaled[600]: magicsock: SetPrivateKey called (init) hub # [ 23.781882] tailscaled[616]: netmap: suggested exit node: () worker # [ 20.125252] tailscaled[600]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) hub # [ 23.784355] tailscaled[616]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) worker # [ 20.129516] tailscaled[600]: wgengine: Reconfig: configuring router hub # [ 23.786875] tailscaled[616]: wgengine: Reconfig: configuring router hub # [ 23.790604] tailscaled[616]: wgengine: Reconfig: user dialer hub # [ 23.793916] tailscaled[616]: tsdial: bart table size: 4 hub # [ 23.795353] tailscaled[616]: wgengine: Reconfig: configuring DNS hub # [ 23.796976] tailscaled[616]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} hub # [ 23.859595] tailscaled[616]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} hub # [ 23.861923] tailscaled[616]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 20.253120] tailscaled[600]: router: enabling connmark-based rp_filter workaround hub # [ 23.913605] tailscaled[616]: netmap: suggested exit node: () hub # [ 23.915534] tailscaled[616]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)") worker # [ 20.277560] tailscaled[600]: wgengine: Reconfig: user dialer worker # [ 20.278991] tailscaled[600]: tsdial: bart table size: 4 worker # [ 20.280334] tailscaled[600]: wgengine: Reconfig: configuring DNS worker # [ 20.281825] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} worker # [ 20.298924] tailscaled[600]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} worker # [ 20.301355] tailscaled[600]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 20.345162] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 20.347747] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 20.351780] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 20.353711] systemd[1]: Stopping User and Group Name Lookups... worker # [ 20.355835] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 20.358522] systemd[1]: nscd.service: Deactivated successfully. worker # [ 20.360527] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 20.363354] tailscaled[600]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [2ms] (forced=false) worker # [ 20.366104] tailscaled[600]: magicsock: home is now derp-999 () worker # [ 20.369932] tailscaled[600]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::2ee1:148f:2f89:d875]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local) worker # [ 20.379244] tailscaled[600]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 20.382166] tailscaled[600]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 20.383924] tailscaled[600]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 20.387890] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 20.396375] tailscaled[600]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 20.412227] tailscaled[600]: peerapi: serving on http://100.64.0.2:46590 hub # [ 24.063742] tailscaled[616]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 20.416247] tailscaled[600]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 20.422659] tailscaled[600]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 20.425830] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 20.427742] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 20.429904] systemd[1]: Reached target User and Group Name Lookups. worker # [ 20.433313] tailscaled[600]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 20.436704] nsncd[917]: Jul 13 16:23:26.754 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 20.445558] tailscaled[600]: netmap: suggested exit node: () worker # [ 20.450110] tailscaled[600]: writing netmap to disk cache worker # [ 20.452436] tailscaled[600]: health(warnable=warming-up): ok worker # [ 20.453833] tailscaled[600]: health(warnable=no-derp-connection): ok worker # [ 20.455349] tailscaled[600]: health(warnable=no-derp-connection): ok worker # [ 20.456882] tailscaled[600]: [RATELIMIT] format("health(warnable=%s): ok") worker # [ 20.460885] tailscaled[600]: magicsock: derp-999 connected; connGen=1 worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-tKnEMWwel-RT-vwjqIWljBvGoG_hqY1qOxp80Mgrf6PfYQXep8SYOkYmpYxTDYVej0ScAeRwCEdoO --hostname tt-worker, in 2.55 seconds) worker: waiting for success: tailscale ping hub worker # [ 20.491359] tailscaled[600]: localapi: [POST] /localapi/v0/ping worker # [ 20.493972] tailscaled[600]: ping(100.64.0.1): sending disco ping to [NRCQh] hub ... worker # [ 20.499791] tailscaled[600]: magicsock: disco: node [NRCQh] d:2df808ea2a7653c2 now using 192.168.1.1:41641 mtu=1360 tx=bab7ccc1f200 worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds) hub: must succeed: tailscale ip -4 hub # [ 24.188786] headscale-start[894]: 2026-07-13T16:23:27Z INF http request bytes=0 elapsed=109.15717 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58954 status=200 hub # [ 24.200475] headscale-start[894]: 2026-07-13T16:23:27Z INF http request bytes=0 elapsed=107.869296 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58976 status=200 hub: (finished: must succeed: tailscale ip -4, in 0.08 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.04 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 24.317243] systemd[1]: Starting tribuchet-hub.socket... hub # [ 24.328225] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 24.333526] systemd[1]: Starting tribuchet-hub.service... worker # [ 20.701102] tailscaled[600]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 24.409475] tribuchet[1094]: 2026-07-13T16:23:27.370003Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 24.415146] tribuchet[1094]: 2026-07-13T16:23:27.377404Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers hub # [ 24.420588] tribuchet[1094]: 2026-07-13T16:23:27.382813Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 24.428869] tribuchet[1094]: 2026-07-13T16:23:27.391264Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 24.433721] systemd[1]: Started tribuchet-hub.service. hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.16 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 20.847540] systemd[1]: Starting tribuchet-worker.service... worker # [ 20.907471] tailscaled[600]: [RATELIMIT] format("control: [v\x00JSON]%d%s") worker # [ 20.913118] tailscaled[600]: netmap: suggested exit node: () worker # [ 20.916527] tailscaled[600]: netmap: suggested exit node: () worker # [ 20.963919] exec[958]: 2026-07-13T16:23:27.285190Z 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 } worker # [ 20.979345] exec[961]: 2026-07-13T16:23:27.300407Z 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 } worker # [ 20.995061] exec[961]: 2026-07-13T16:23:27.316662Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 21.002651] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.22 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' hub # [ 24.695311] tailscaled[616]: magicsock: disco: node [YvaZW] d:e7c2333878e7b8bb now using [2001:db8:1::2]:41641 mtu=1360 tx=afaa615b0270 worker # [ 21.057580] tailscaled[600]: magicsock: disco: node [NRCQh] d:2df808ea2a7653c2 now using [2001:db8:1::1]:41641 mtu=1360 tx=a59a880a24c0 hub # [ 24.713157] headscale-start[894]: 2026-07-13T16:23:27Z INF http request bytes=0 elapsed=499.298933 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58976 status=200 hub # [ 24.764565] tribuchet[1094]: 2026-07-13T16:23:27.726943Z 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.142287] exec[961]: 2026-07-13T16:23:27.463504Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] hub # [ 25.194121] headscale-start[894]: 2026-07-13T16:23:28Z INF http request bytes=0 elapsed=466.436377 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:58976 status=200 worker # [ 21.719290] tailscaled[600]: netmap: suggested exit node: () worker # [ 21.728990] tailscaled[600]: netmap: suggested exit node: () worker # [ 21.733194] tailscaled[600]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)") hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.19 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/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9"; 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/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9"; 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/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv hub # building '/nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv'... hub # [ 26.290449] tribuchet[1094]: 2026-07-13T16:23:29.252433Z INFO tribuchet::hub::submit: queueing build id="6fdf51f038ffd5cea456ccc865891e04" system="x86_64-linux" hub # [ 26.295387] tribuchet[1094]: 2026-07-13T16:23:29.257703Z INFO tribuchet::hub: dispatching build id="6fdf51f038ffd5cea456ccc865891e04" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 22.656589] exec[961]: 2026-07-13T16:23:28.972363Z INFO tribuchet::worker: build assigned id="6fdf51f038ffd5cea456ccc865891e04" worker # [ 22.675183] systemd[1]: Started Nix Daemon. worker # [ 22.733351] nix-daemon[964]: accepted connection from pid 961, user tribuchet (trusted) worker # [ 22.740695] exec[961]: 2026-07-13T16:23:29.062335Z INFO harmonia_store_remote::client: Client Version is 1.38, server version is 1.38 version=ProtocolVersion(1, 38) server_version=ProtocolVersion(1, 38) features={} worker # [ 22.746662] exec[961]: 2026-07-13T16:23:29.068058Z INFO harmonia_store_remote::client: Nix Version "2.34.8" version="2.34.8" hub # [ 26.407916] tribuchet[1094]: 2026-07-13T16:23:29.370315Z INFO tribuchet::hub::relay: input path negotiation done id="6fdf51f038ffd5cea456ccc865891e04" total=8 missing=1 hub # [ 26.430899] systemd[1]: Started Nix Daemon. hub # [ 26.555274] nix-daemon[1129]: accepted connection from pid 1094, user root (trusted) hub # [ 26.564387] tribuchet[1094]: 2026-07-13T16:23:29.526520Z INFO harmonia_store_remote::client: Client Version is 1.38, server version is 1.38 version=ProtocolVersion(1, 38) server_version=ProtocolVersion(1, 38) features={} hub # [ 26.570826] tribuchet[1094]: 2026-07-13T16:23:29.533343Z INFO harmonia_store_remote::client: Nix Version "2.34.8+2" version="2.34.8+2" worker # [ 22.986235] exec[961]: 2026-07-13T16:23:29.307634Z INFO tribuchet::worker::build: sandbox network decision id="6fdf51f038ffd5cea456ccc865891e04" fixed_output=false network=false net_isolation=false worker # [ 23.016551] systemd[1]: Starting tribuchet-sandboxd.service... worker # [ 23.056089] tribuchet-sandboxd[972]: 2026-07-13T16:23:29.376165Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock worker # [ 23.059864] systemd[1]: Started tribuchet-sandboxd.service. worker # [ 23.063130] exec[961]: 2026-07-13T16:23:29.384055Z INFO tribuchet::worker::build: leased sandbox build_id="6fdf51f038ffd5cea456ccc865891e04" pool_base=1325400064 uid_count=1 worker # [ 23.067911] tribuchet-sandboxd[972]: 2026-07-13T16:23:29.384701Z INFO tribuchet_sandboxd: leased build="6fdf51f038ffd5cea456ccc865891e04" base=1325400064 uid_count=1 worker # [ 23.264619] tribuchet-sandboxd[972]: 2026-07-13T16:23:29.585653Z INFO tribuchet_sandboxd: released build="6fdf51f038ffd5cea456ccc865891e04" base=1325400064 worker # [ 23.277255] exec[961]: 2026-07-13T16:23:29.597134Z INFO tribuchet::worker::build: builder finished id="6fdf51f038ffd5cea456ccc865891e04" exit_code=0 worker # [ 23.305140] exec[961]: 2026-07-13T16:23:29.625505Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="6fdf51f038ffd5cea456ccc865891e04" worker # [ 23.325861] exec[961]: 2026-07-13T16:23:29.647447Z INFO tribuchet::worker::resume: build result acknowledged id="6fdf51f038ffd5cea456ccc865891e04" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 0.99 seconds) hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-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.27 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.496661] systemd[1]: Stopping tribuchet-worker.service... worker # [ 23.498878] exec[961]: 2026-07-13T16:23:29.819785Z INFO tribuchet::worker: handover requested; exiting hub # [ 27.158588] tribuchet[1094]: 2026-07-13T16:23:30.120321Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 23.706320] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 23.713199] systemd[1]: Stopped tribuchet-worker.service. worker # [ 23.717918] systemd[1]: tribuchet-worker.service: Consumed 97ms CPU time over 2.858s wall clock time, 18M memory peak, 14.3M read from disk, 4K written to disk, 3.9K incoming IP traffic, 2.1K outgoing IP traffic. worker # [ 23.744197] systemd[1]: Starting tribuchet-worker.service... worker # [ 23.799615] exec[996]: 2026-07-13T16:23:30.121019Z 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 } worker # [ 23.813305] exec[999]: 2026-07-13T16:23:30.134559Z 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 } worker # [ 23.824245] exec[999]: 2026-07-13T16:23:30.145584Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 23.831637] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.36 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' hub # [ 27.864628] tribuchet[1094]: 2026-07-13T16:23:30.825995Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:59732 worker # [ 24.222462] exec[999]: 2026-07-13T16:23:30.543889Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 24.233954] exec[999]: 2026-07-13T16:23:30.543979Z 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.52 seconds) (finished: run the VM test script, in 29.75 seconds) test script finished in 29.84s cleanup kill QemuMachine (pid 48) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14) kill QemuMachine (pid 47) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.35 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