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 47) hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.nNqjuUqCaJ', 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: 9d58db14-b94d-4020-b2e3-aa6a859fd357 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[ 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/zgzkwzc0py7zqi6y54rgz8qp7jlgacvz-nixos-system-hub-test/init regInfo=/nix/store/4xprr052amsm82r31ix5dy0aj4vh4y8x-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.000000] BIOS-provided physical RAM map: hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved hub # [ 0.000000] NX (Execute Disable) protection: active hub # [ 0.000000] APIC: Static calls initialized hub # [ 0.000000] SMBIOS 2.8 present. hub # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 hub # [ 0.000000] DMI: Memory slots populated: 1/1 hub # [ 0.000000] Hypervisor detected: KVM hub # [ 0.000000] last_pfn = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000000] kvm-clock: using sched offset of 483150046 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.000814] last_pfn = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000850] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000853] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002763] found SMP MP-table at [mem 0x000f5470-0x000f547f] hub # [ 0.002774] Using GB pages for direct mapping hub # [ 0.002886] RAMDISK: [mem 0x7e302000-0x7ffcffff] hub # [ 0.002894] ACPI: Early table checksum verification disabled hub # [ 0.002896] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) hub # [ 0.002900] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002904] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002911] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002913] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002914] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002916] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002917] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002919] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] hub # [ 0.002920] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] hub # [ 0.002920] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002921] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] hub # [ 0.002921] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] hub # [ 0.002922] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] hub # [ 0.003391] No NUMA configuration found hub # [ 0.003393] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] hub # [ 0.003396] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] hub # [ 0.005682] Zone ranges: hub # [ 0.005683] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005685] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] hub # [ 0.005686] Normal empty hub # [ 0.005686] Device empty hub # [ 0.005687] Movable zone start for each node hub # [ 0.005688] Early memory node ranges hub # [ 0.005688] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005689] node 0: [mem 0x0000000000100000-0x000000007ffdafff] hub # [ 0.005690] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] hub # [ 0.005710] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.005975] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.041732] On node 0, zone DMA32: 37 pages in unavailable ranges hub # [ 0.042713] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.042728] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.042761] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.042764] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.042766] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.042767] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.042768] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.042768] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.042771] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.042772] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.042777] TSC deadline timer available hub # [ 0.042781] CPU topo: Max. logical packages: 1 hub # [ 0.042782] CPU topo: Max. logical dies: 1 hub # [ 0.042782] CPU topo: Max. dies per package: 1 hub # [ 0.042786] CPU topo: Max. threads per core: 1 hub # [ 0.042786] CPU topo: Num. cores per package: 1 hub # [ 0.042786] CPU topo: Num. threads per package: 1 hub # [ 0.042787] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.042808] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.042846] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.042847] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.042849] [mem 0x80000000-0xfeffbfff] available for PCI devices hub # [ 0.042850] Booting paravirtualized kernel on KVM hub # [ 0.042853] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.047292] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.049492] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.049539] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.049540] 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/zgzkwzc0py7zqi6y54rgz8qp7jlgacvz-nixos-system-hub-test/init regInfo=/nix/store/4xprr052amsm82r31ix5dy0aj4vh4y8x-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.049634] Unknown kernel command line parameters "regInfo=/nix/store/4xprr052amsm82r31ix5dy0aj4vh4y8x-closure-info/registration", will be passed to user space. hub # [ 0.049647] random: crng init done hub # [ 0.049647] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.051808] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.051830] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.051861] Fallback order for Node 0: 0 hub # [ 0.051864] Built 1 zonelists, mobility grouping on. Total pages: 524153 hub # [ 0.051864] Policy zone: DMA32 hub # [ 0.054568] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.058190] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.062657] allocated 4194304 bytes of page_ext hub # [ 0.072161] ftrace: allocating 48598 entries in 192 pages hub # [ 0.072163] ftrace: allocated 192 pages with 2 groups hub # [ 0.072990] Dynamic Preempt: lazy hub # [ 0.073134] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.073134] rcu: RCU event tracing is enabled. hub # [ 0.073135] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.073137] Trampoline variant of Tasks RCU enabled. hub # [ 0.073137] Rude variant of Tasks RCU enabled. hub # [ 0.073137] Tracing variant of Tasks RCU enabled. hub # [ 0.073138] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.073139] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.073161] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.073162] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.073163] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077668] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.077940] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.078051] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.085186] Console: colour VGA+ 80x25 hub # [ 0.085190] printk: legacy console [tty0] enabled hub # [ 0.125454] printk: legacy console [ttyS0] enabled hub # [ 0.308856] ACPI: Core revision 20250807 hub # [ 0.310365] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.313247] APIC: Switch to symmetric I/O mode setup hub # [ 0.314981] x2apic enabled hub # [ 0.316191] APIC: Switched APIC routing to: physical x2apic hub # [ 0.319008] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.320811] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.323875] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) hub # [ 0.326000] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.327024] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.327874] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.328878] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.330874] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.331875] Transient Scheduler Attacks: Mitigation: Clear CPU buffers hub # [ 0.333875] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.334874] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.335874] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.336880] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.337875] active return thunk: srso_alias_return_thunk hub # [ 0.339891] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.340874] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.341874] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.343874] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.345874] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.346874] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.347874] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.348874] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 0.350874] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' hub # [ 0.352874] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.353874] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.354874] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.356874] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.358874] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.359874] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 hub # [ 0.360874] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 hub # [ 0.361874] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 0.397473] Freeing SMP alternatives memory: 44K hub # [ 0.397877] pid_max: default: 32768 minimum: 301 hub # [ 0.398982] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.399977] landlock: Up and running. hub # [ 0.400874] Yama: becoming mindful. hub # [ 0.402086] LSM support for eBPF active hub # [ 0.404014] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.404915] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.407610] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.408388] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.408879] ... version: 2 hub # [ 0.409876] ... bit width: 48 hub # [ 0.410928] ... generic counters: 6 hub # [ 0.411876] ... generic bitmap: 000000000000003f hub # [ 0.412876] ... fixed-purpose counters: 0 hub # [ 0.413875] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.414876] ... value mask: 0000ffffffffffff hub # [ 0.415876] ... max period: 00007fffffffffff hub # [ 0.416876] ... global_ctrl mask: 000000000000003f hub # [ 0.418016] signal: max sigframe size: 3376 hub # [ 0.418979] rcu: Hierarchical SRCU implementation. hub # [ 0.419880] rcu: Max phase no-delay instances is 400. hub # [ 0.425497] smp: Bringing up secondary CPUs ... hub # [ 0.425892] smp: Brought up 1 node, 1 CPU hub # [ 0.426878] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) hub # [ 0.428102] Memory: 1969264K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved) hub # [ 0.429191] devtmpfs: initialized hub # [ 0.430137] x86/mm: Memory block size: 128MB hub # [ 0.432023] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.432908] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.433904] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.434972] pinctrl core: initialized pinctrl subsystem hub # [ 0.436184] PM: RTC time: 09:39:53, date: 2026-07-13 hub # [ 0.439611] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.441420] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.441902] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.443155] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.443887] audit: initializing netlink subsys (disabled) hub # [ 0.445134] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.445136] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.445879] audit: type=2000 audit(1783935594.176:1): state=initialized audit_enabled=0 res=1 hub # [ 0.447879] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.447881] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.448876] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.449927] cpuidle: using governor menu hub # [ 0.453027] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.454159] PCI: Using configuration type 1 for base access hub # [ 0.454876] PCI: Using configuration type 1 for extended access hub # [ 0.456076] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.462894] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.463877] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.468875] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.469877] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.481155] ACPI: Added _OSI(Module Device) hub # [ 0.481877] ACPI: Added _OSI(Processor Device) hub # [ 0.483913] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.488721] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.495116] ACPI: Interpreter enabled hub # [ 0.495894] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.496877] ACPI: Using IOAPIC for interrupt routing hub # [ 0.497906] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.500875] PCI: Using E820 reservations for host bridge windows hub # [ 0.502024] ACPI: Enabled 2 GPEs in block 00 to 0F hub # [ 0.510166] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.510883] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.512252] acpiphp: Slot [3] registered hub # [ 0.512919] acpiphp: Slot [4] registered hub # [ 0.513930] acpiphp: Slot [5] registered hub # [ 0.514917] acpiphp: Slot [6] registered hub # [ 0.515916] acpiphp: Slot [7] registered hub # [ 0.516934] acpiphp: Slot [8] registered hub # [ 0.517981] acpiphp: Slot [9] registered hub # [ 0.518931] acpiphp: Slot [10] registered hub # [ 0.519918] acpiphp: Slot [11] registered hub # [ 0.520937] acpiphp: Slot [12] registered hub # [ 0.521919] acpiphp: Slot [13] registered hub # [ 0.522908] acpiphp: Slot [14] registered hub # [ 0.523908] acpiphp: Slot [15] registered hub # [ 0.524922] acpiphp: Slot [16] registered hub # [ 0.525909] acpiphp: Slot [17] registered hub # [ 0.526908] acpiphp: Slot [18] registered hub # [ 0.527908] acpiphp: Slot [19] registered hub # [ 0.528921] acpiphp: Slot [20] registered hub # [ 0.529908] acpiphp: Slot [21] registered hub # [ 0.530908] acpiphp: Slot [22] registered hub # [ 0.531908] acpiphp: Slot [23] registered hub # [ 0.532925] acpiphp: Slot [24] registered hub # [ 0.533934] acpiphp: Slot [25] registered hub # [ 0.534908] acpiphp: Slot [26] registered hub # [ 0.535923] acpiphp: Slot [27] registered hub # [ 0.536910] acpiphp: Slot [28] registered hub # [ 0.537932] acpiphp: Slot [29] registered hub # [ 0.538923] acpiphp: Slot [30] registered hub # [ 0.539922] acpiphp: Slot [31] registered hub # [ 0.540900] PCI host bridge to bus 0000:00 hub # [ 0.541883] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.542876] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.543877] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.544877] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] hub # [ 0.545885] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] hub # [ 0.546877] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.548192] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.549760] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.551779] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint hub # [ 0.554716] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] hub # [ 0.555940] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk hub # [ 0.556876] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk hub # [ 0.557876] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk hub # [ 0.558876] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk hub # [ 0.560296] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.561941] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] hub # [ 0.564115] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint hub # [ 0.565496] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI hub # [ 0.566891] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB hub # [ 0.568293] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.570952] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.571906] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.572935] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.574140] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.576133] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.578912] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.579891] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.580928] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.581890] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.585045] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.587913] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.588890] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.589928] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.592939] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.595804] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.596890] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.597928] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.600876] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.603911] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.605891] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.606928] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.609902] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.612914] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.613890] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.614940] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.617902] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.620968] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.621942] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.622927] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.626601] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.629876] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.630891] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.631939] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.632891] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.635849] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.637903] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.638928] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.641828] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.644922] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.645890] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.646928] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.649889] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.652877] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.653891] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.654928] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.663252] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.664084] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.665065] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.666068] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.666981] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 hub # [ 0.669183] iommu: Default domain type: Translated hub # [ 0.669886] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.671162] ACPI: bus type USB registered hub # [ 0.671932] usbcore: registered new interface driver usbfs hub # [ 0.672907] usbcore: registered new interface driver hub hub # [ 0.673887] usbcore: registered new device driver usb hub # [ 0.675828] NetLabel: Initializing hub # [ 0.676676] NetLabel: domain hash size = 128 hub # [ 0.677875] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.678917] NetLabel: unlabeled traffic allowed by default hub # [ 0.679891] PCI: Using ACPI for IRQ routing hub # [ 0.681551] pci 0000:00:02.0: vgaarb: setting as boot VGA device hub # [ 0.681871] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 0.681871] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.681877] vgaarb: loaded hub # [ 0.683013] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.683875] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.687961] clocksource: Switched to clocksource kvm-clock hub # [ 0.692071] VFS: Disk quotas dquot_6.6.0 hub # [ 0.693331] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.695541] pnp: PnP ACPI init hub # [ 0.697213] pnp: PnP ACPI: found 6 devices hub # [ 0.705385] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.707913] clocksource: Switched to clocksource acpi_pm hub # [ 0.709663] NET: Registered PF_INET protocol family hub # [ 0.711520] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.729433] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.732100] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.734379] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.736719] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.738971] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.740983] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.743190] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.745139] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.747256] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.748985] NET: Registered PF_XDP protocol family hub # [ 0.750475] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.752289] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.754098] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.756088] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] hub # [ 0.758077] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] hub # [ 0.760203] pci 0000:00:01.0: PIIX3: Enabling Passive Release hub # [ 0.761965] pci 0000:00:00.0: Limiting direct PCI/PCI transfers hub # [ 0.765278] ACPI: \_SB_.LNKD: Enabled at IRQ 11 hub # [ 0.768614] PCI: CLS 0 bytes, default 64 hub # [ 0.770179] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.773118] Trying to unpack rootfs image as initramfs... hub # [ 0.820228] Initialise system trusted keyrings hub # [ 0.825017] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.850275] Key type asymmetric registered hub # [ 0.851567] Asymmetric key parser 'x509' registered hub # [ 0.857031] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.862037] io scheduler mq-deadline registered hub # [ 0.864975] io scheduler kyber registered hub # [ 0.868576] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.870799] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.879576] Linux agpgart interface v0.103 hub # [ 0.882983] ACPI: bus type drm_connector registered hub # [ 0.887186] usbcore: registered new interface driver usbserial_generic hub # [ 0.889098] usbserial: USB Serial support registered for generic hub # [ 0.894980] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.894980] Please enable it if your BIOS has the CPPC option. hub # [ 0.898875] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.906123] drop_monitor: Initializing network drop monitor service hub # [ 0.908093] NET: Registered PF_INET6 protocol family hub # [ 0.913553] Segment Routing with IPv6 hub # [ 0.917996] In-situ OAM (IOAM) with IPv6 hub # [ 0.919635] IPI shorthand broadcast: enabled hub # [ 0.928303] sched_clock: Marking stable (689031784, 238922866)->(1120193108, -192238458) hub # [ 0.935122] registered taskstats version 1 hub # [ 0.936666] Loading compiled-in X.509 certificates hub # [ 0.958578] Demotion targets for Node 0: null hub # [ 0.962033] Key type .fscrypt registered hub # [ 0.965980] Key type fscrypt-provisioning registered hub # [ 0.967734] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.970973] ima: Allocated hash algorithm: sha1 hub # [ 0.972415] ima: No architecture policies found hub # [ 0.978160] PM: Magic number: 2:70:677 hub # [ 0.982363] RAS: Correctable Errors collector initialized. hub # [ 0.991818] clk: Disabling unused clocks hub # [ 0.996976] PM: genpd: Disabling unused power domains hub # [ 1.138720] Freeing initrd memory: 29496K hub # [ 1.142632] Freeing unused decrypted memory: 2028K hub # [ 1.146013] Freeing unused kernel image (initmem) memory: 3636K hub # [ 1.147874] Write protecting the kernel read-only data: 32768k hub # [ 1.150605] Freeing unused kernel image (text/rodata gap) memory: 1272K hub # [ 1.153057] Freeing unused kernel image (rodata/data gap) memory: 796K hub # [ 1.206061] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.208013] Run /init as init process hub # [ 1.219473] systemd[1]: Inserted module 'autofs4' hub # [ 1.236383] fuse: init (API version 7.45) hub # [ 1.243769] ACPI: \_SB_.LNKC: Enabled at IRQ 10 hub # [ 1.252626] ACPI: \_SB_.LNKA: Enabled at IRQ 10 hub # [ 1.257080] ACPI: \_SB_.LNKB: Enabled at IRQ 11 hub # [ 1.301986] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.641294] 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.662485] systemd[1]: Detected virtualization kvm. hub # [ 1.666417] systemd[1]: Detected architecture x86-64. hub # [ 1.670370] systemd[1]: Running in initrd. hub # [ 1.674575] systemd[1]: Initializing machine ID from random generator. hub # [ 1.679637] systemd[1]: Hostname set to . hub # [ 1.901472] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.961558] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.966584] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.968633] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.971082] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.973127] systemd[1]: Reached target Path Units. hub # [ 1.974680] systemd[1]: Reached target Slice Units. hub # [ 1.976313] systemd[1]: Reached target Swaps. hub # [ 1.977743] systemd[1]: Reached target Timer Units. hub # [ 1.979488] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.981612] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.983659] systemd[1]: Listening on Journal Sockets. hub # [ 1.985446] systemd[1]: Listening on udev Control Socket. hub # [ 1.987258] systemd[1]: Listening on udev Kernel Socket. hub # [ 1.988969] systemd[1]: Reached target Socket Units. hub # [ 1.991674] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 1.998088] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.009053] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.021049] systemd[1]: Starting Journal Service... hub # [ 2.038050] systemd[1]: Starting Load Kernel Modules... hub # [ 2.045877] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.061390] netfs: FS-Cache loaded hub # [ 2.068742] 9pnet: Installing 9P2000 support hub # [ 2.093187] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.100773] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.106973] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.114047] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.117740] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.122106] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.132865] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.142509] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.154465] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.163077] systemd[1]: Finished Load Kernel Modules. hub # [ 2.168759] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.183204] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.203093] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.229139] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.243104] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.253188] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.287139] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.294686] systemd[1]: Started Journal Service. hub # [ 2.054989] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.059883] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.062478] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.065484] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.070667] systemd[1]: Reached target Local File Systems. hub # [ 2.072566] systemd[1]: Starting Create System Files and Directories... hub # [ 2.079350] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.114773] systemd[1]: Finished Create System Files and Directories. hub # [ 2.142601] systemd-udevd[76]: Using default interface naming scheme 'v261'. hub # [ 2.178109] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.220335] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.223099] systemd[1]: Reached target System Initialization. hub # [ 2.225837] systemd[1]: Reached target Basic System. worker: QEMU running (pid 48) worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.Pb9vtOXyMC', fmt=raw size=1073741824 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/262144 done worker # Creating filesystem with 262144 4k blocks and 65536 inodes (finished: start all VMs, in 3.46 seconds) worker # Filesystem UUID: 222ce66b-4f53-48b8-af0b-d72e1bbec002 hub: waiting for unit headscale worker # Superblock backups stored on blocks: hub: waiting for the VM to finish booting worker # 32768, 98304, 163840, 229376 worker # worker # Allocating group tables: 0/8 done worker # Writing inode tables: 0/8 done worker # Creating journal (8192 blocks): done worker # Writing superblocks and filesystem accounting information: 0/8 done worker # worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) 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 hub # [ 2.798620] uhci_hcd 0000:00:01.2: UHCI Host Controller worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)... worker # worker # hub # [ 2.813286] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 hub # [ 2.815079] uhci_hcd 0000:00:01.2: detected 2 ports hub # [ 2.827678] SCSI subsystem initialized hub # [ 2.829564] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 2.832339] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # Booting from ROM... hub # [ 2.842355] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 hub # [ 2.849635] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 2.851805] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.861066] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.862956] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.871428] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.895960] usb usb1: Product: UHCI Host Controller hub # [ 2.661178] systemd[1]: Starting Virtual Console Setup... hub # [ 2.915616] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd hub # [ 2.682107] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.689315] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.698840] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.707342] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.951263] usb usb1: SerialNumber: 0000:00:01.2 hub # [ 2.714428] systemd[1]: Finished Virtual Console Setup. hub # [ 2.956517] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.965752] hub 1-0:1.0: USB hub found hub # [ 2.971588] hub 1-0:1.0: 2 ports detected hub # [ 2.761454] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.763384] systemd[1]: Reached target Initrd Root Device. hub # [ 2.767476] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 3.024873] scsi host0: ata_piix hub # [ 3.031822] scsi host1: ata_piix hub # [ 3.033366] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 hub # [ 3.040747] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 hub # [ 2.807708] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.815383] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.869145] systemd[1]: Mounting /sysroot... hub # [ 3.197534] ata2: found unknown device (class 0) worker # Probing EDD (edd=off to disable)... ok[ 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 # [ 3.201828] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 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/jfblc23in63zx144sr9kfhfhdc5fyhn9-nixos-system-worker-test/init regInfo=/nix/store/4aq57bwm439kb1kh2svs9l9f6m01m9by-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 hub # [ 3.206399] usb 1-1: new full-speed USB device number 2 using uhci_hcd 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 hub # [ 3.214361] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 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.000000] kvm-clock: using sched offset of 491300564 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.000811] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000847] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000850] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.002751] found SMP MP-table at [mem 0x000f5470-0x000f547f] worker # [ 0.002762] Using GB pages for direct mapping worker # [ 0.002845] RAMDISK: [mem 0x7e2fa000-0x7ffcffff] worker # [ 0.002853] ACPI: Early table checksum verification disabled worker # [ 0.002855] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) worker # [ 0.002859] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002863] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002869] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002871] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002873] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002874] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002876] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002877] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] worker # [ 0.002878] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] worker # [ 0.002879] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002879] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] worker # [ 0.002880] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] worker # [ 0.002880] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] worker # [ 0.003352] No NUMA configuration found worker # [ 0.003353] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] worker # [ 0.003356] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] worker # [ 0.005643] Zone ranges: worker # [ 0.005643] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.005645] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] worker # [ 0.005646] Normal empty worker # [ 0.005647] Device empty worker # [ 0.005647] Movable zone start for each node worker # [ 0.005648] Early memory node ranges worker # [ 0.005648] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 3.279704] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 0.005649] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] worker # [ 0.005650] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] worker # [ 0.005672] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.005944] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.041751] On node 0, zone DMA32: 40 pages in unavailable ranges worker # [ 0.042727] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.042750] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.042784] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.042787] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.042789] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.042790] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.042791] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 3.298385] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 0.042792] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.042794] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.042795] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.042799] TSC deadline timer available worker # [ 0.042803] CPU topo: Max. logical packages: 1 worker # [ 0.042804] CPU topo: Max. logical dies: 1 worker # [ 0.042805] CPU topo: Max. dies per package: 1 worker # [ 0.042808] CPU topo: Max. threads per core: 1 worker # [ 0.042808] CPU topo: Num. cores per package: 1 worker # [ 0.042809] CPU topo: Num. threads per package: 1 worker # [ 0.042809] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.042831] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.042868] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.042870] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.042871] [mem 0x80000000-0xfeffbfff] available for PCI devices worker # [ 0.042873] Booting paravirtualized kernel on KVM worker # [ 0.042876] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 3.319620] EXT4-fs (vda): mounted filesystem 9d58db14-b94d-4020-b2e3-aa6a859fd357 r/w with ordered data mode. Quota mode: none. worker # [ 0.047307] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.049491] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.049538] kvm-guest: PV spinlocks disabled, single CPU hub # [ 3.086796] systemd[1]: Mounted /sysroot. hub # [ 3.088811] systemd[1]: Reached target Initrd Root File System. worker # [ 0.049540] 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/jfblc23in63zx144sr9kfhfhdc5fyhn9-nixos-system-worker-test/init regInfo=/nix/store/4aq57bwm439kb1kh2svs9l9f6m01m9by-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.049634] Unknown kernel command line parameters "regInfo=/nix/store/4aq57bwm439kb1kh2svs9l9f6m01m9by-closure-info/registration", will be passed to user space. hub # [ 3.096707] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 0.049646] random: crng init done worker # [ 0.049647] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.051817] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.051840] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.051872] Fallback order for Node 0: 0 worker # [ 0.051874] Built 1 zonelists, mobility grouping on. Total pages: 524150 worker # [ 0.051875] Policy zone: DMA32 worker # [ 0.054501] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.058096] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.062532] allocated 4194304 bytes of page_ext hub # [ 3.109297] systemd-sysroot-fstab-check[127]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 0.072019] ftrace: allocating 48598 entries in 192 pages worker # [ 0.072021] ftrace: allocated 192 pages with 2 groups worker # [ 0.072845] Dynamic Preempt: lazy worker # [ 0.072967] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.072968] rcu: RCU event tracing is enabled. hub # [ 3.115954] systemd[1]: Reload requested from client PID 127 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 0.072968] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 3.118705] systemd[1]: Reloading... worker # [ 0.072970] Trampoline variant of Tasks RCU enabled. worker # [ 0.072970] Rude variant of Tasks RCU enabled. worker # [ 0.072971] Tracing variant of Tasks RCU enabled. worker # [ 0.072971] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.072972] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.073022] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.073024] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.073025] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.077551] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.077821] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.077930] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.085073] Console: colour VGA+ 80x25 worker # [ 0.085077] printk: legacy console [tty0] enabled worker # [ 0.125649] printk: legacy console [ttyS0] enabled worker # [ 0.308786] ACPI: Core revision 20250807 worker # [ 0.310303] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.313026] APIC: Switch to symmetric I/O mode setup worker # [ 0.314742] x2apic enabled hub # [ 3.384240] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 3.386180] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 0.315957] APIC: Switched APIC routing to: physical x2apic worker # [ 0.318789] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 3.390967] usb 1-1: Product: QEMU USB Tablet worker # [ 0.320568] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 3.393486] usb 1-1: Manufacturer: QEMU worker # [ 0.323627] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) hub # [ 3.395645] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 0.325742] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.326789] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.327625] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.328629] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.330626] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.331625] Transient Scheduler Attacks: Mitigation: Clear CPU buffers worker # [ 0.332625] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.333625] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.334624] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.335631] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.337625] active return thunk: srso_alias_return_thunk worker # [ 0.338654] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.340624] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.341625] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.343625] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 3.432468] hid: raw HID events driver (C) Jiri Kosina worker # [ 0.344624] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.345624] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' worker # [ 0.346625] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.347625] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' worker # [ 0.348625] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' worker # [ 0.350625] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.351624] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 worker # [ 0.353625] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 worker # [ 0.355624] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.356624] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.357624] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 worker # [ 0.358625] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 worker # [ 0.360625] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 3.461971] usbcore: registered new interface driver usbhid hub # [ 3.470966] usbhid: USB HID core driver hub # [ 3.487305] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 0.395567] Freeing SMP alternatives memory: 44K worker # [ 0.396626] pid_max: default: 32768 minimum: 301 hub # [ 3.493264] 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.397732] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.399743] landlock: Up and running. worker # [ 0.401476] Yama: becoming mindful. worker # [ 0.402838] LSM support for eBPF active worker # [ 0.403734] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.405670] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.408725] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.410179] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.410635] ... version: 2 worker # [ 0.411626] ... bit width: 48 worker # [ 0.412626] ... generic counters: 6 worker # [ 0.413626] ... generic bitmap: 000000000000003f worker # [ 0.414626] ... fixed-purpose counters: 0 worker # [ 0.415626] ... fixed-purpose bitmap: 0000000000000000 hub # [ 3.279776] systemd[1]: Reloading finished in 159 ms. worker # [ 0.416626] ... value mask: 0000ffffffffffff worker # [ 0.417626] ... max period: 00007fffffffffff worker # [ 0.418626] ... global_ctrl mask: 000000000000003f worker # [ 0.419744] signal: max sigframe size: 3376 worker # [ 0.420721] rcu: Hierarchical SRCU implementation. worker # [ 0.421630] rcu: Max phase no-delay instances is 400. hub # [ 3.291581] systemd-sysroot-fstab-check[127]: Requesting initrd-fs.target/start/replace... worker # [ 0.427260] smp: Bringing up secondary CPUs ... worker # [ 0.427642] smp: Brought up 1 node, 1 CPU worker # [ 0.428629] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) hub # [ 3.298258] systemd-sysroot-fstab-check[127]: Requesting swap.target/start/replace... worker # [ 0.429885] Memory: 1969228K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved) worker # [ 0.430918] devtmpfs: initialized hub # [ 3.302794] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 0.431923] x86/mm: Memory block size: 128MB hub # [ 3.306297] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 0.433743] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 3.308766] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 0.434659] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 3.311232] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 0.435654] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.436734] pinctrl core: initialized pinctrl subsystem worker # [ 0.437964] PM: RTC time: 09:39:57, date: 2026-07-13 worker # [ 0.441372] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.443145] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.443651] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.444907] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.445637] audit: initializing netlink subsys (disabled) worker # [ 0.446893] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.446895] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.447630] audit: type=2000 audit(1783935597.441:1): state=initialized audit_enabled=0 res=1 worker # [ 0.449629] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.449631] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.450627] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.451648] cpuidle: using governor menu worker # [ 0.454776] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.455904] PCI: Using configuration type 1 for base access worker # [ 0.456627] PCI: Using configuration type 1 for extended access worker # [ 0.457860] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.462912] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.463627] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.468626] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.469627] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.479974] ACPI: Added _OSI(Module Device) worker # [ 0.480627] ACPI: Added _OSI(Processor Device) worker # [ 0.485626] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.490475] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.494450] ACPI: Interpreter enabled worker # [ 0.495522] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.498626] ACPI: Using IOAPIC for interrupt routing worker # [ 0.499651] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.502626] PCI: Using E820 reservations for host bridge windows worker # [ 0.503785] ACPI: Enabled 2 GPEs in block 00 to 0F worker # [ 0.511671] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.512633] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.513995] acpiphp: Slot [3] registered worker # [ 0.514670] acpiphp: Slot [4] registered worker # [ 0.515680] acpiphp: Slot [5] registered worker # [ 0.516674] acpiphp: Slot [6] registered worker # [ 0.517711] acpiphp: Slot [7] registered worker # [ 0.518669] acpiphp: Slot [8] registered worker # [ 0.519682] acpiphp: Slot [9] registered worker # [ 0.520668] acpiphp: Slot [10] registered worker # [ 0.521667] acpiphp: Slot [11] registered worker # [ 0.522680] acpiphp: Slot [12] registered worker # [ 0.523667] acpiphp: Slot [13] registered worker # [ 0.524659] acpiphp: Slot [14] registered worker # [ 0.525659] acpiphp: Slot [15] registered worker # [ 0.526683] acpiphp: Slot [16] registered worker # [ 0.527660] acpiphp: Slot [17] registered worker # [ 0.528659] acpiphp: Slot [18] registered worker # [ 0.529659] acpiphp: Slot [19] registered worker # [ 0.530680] acpiphp: Slot [20] registered worker # [ 0.531660] acpiphp: Slot [21] registered worker # [ 0.532658] acpiphp: Slot [22] registered worker # [ 0.533659] acpiphp: Slot [23] registered worker # [ 0.534672] acpiphp: Slot [24] registered worker # [ 0.535660] acpiphp: Slot [25] registered worker # [ 0.536659] acpiphp: Slot [26] registered worker # [ 0.537697] acpiphp: Slot [27] registered worker # [ 0.538661] acpiphp: Slot [28] registered worker # [ 0.539683] acpiphp: Slot [29] registered worker # [ 0.540660] acpiphp: Slot [30] registered worker # [ 0.541673] acpiphp: Slot [31] registered worker # [ 0.542649] PCI host bridge to bus 0000:00 worker # [ 0.543633] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.544628] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.545627] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.546627] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] worker # [ 0.547628] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] worker # [ 0.548629] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.549967] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.551544] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.553531] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint worker # [ 0.556422] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f] worker # [ 0.557691] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk worker # [ 0.558627] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk worker # [ 0.559627] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk worker # [ 0.560627] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk worker # [ 0.562027] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.563692] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f] worker # [ 0.565839] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint worker # [ 0.567249] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI worker # [ 0.568662] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB worker # [ 0.570023] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.572705] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.573658] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.574679] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.575861] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.577671] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.580668] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] worker # [ 0.581641] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.582679] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.583641] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.586788] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.589662] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.590967] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.591704] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.594674] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.597628] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.598641] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.599679] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.602626] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.605641] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.607643] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.608706] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.611614] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.614663] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.615641] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.616679] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.619615] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.622664] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.623641] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.624678] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.628265] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.631627] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.632641] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.633687] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.634641] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.637585] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.639654] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.640679] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] worker # [ 0.643599] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.646669] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.647641] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.648679] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.651652] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.654627] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.655641] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.656678] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.665002] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.665841] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.666825] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.667819] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.668732] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 worker # [ 0.670925] iommu: Default domain type: Translated worker # [ 0.671637] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.672918] ACPI: bus type USB registered worker # [ 0.673683] usbcore: registered new interface driver usbfs worker # [ 0.674656] usbcore: registered new interface driver hub worker # [ 0.675650] usbcore: registered new device driver usb worker # [ 0.677522] NetLabel: Initializing worker # [ 0.678456] NetLabel: domain hash size = 128 worker # [ 0.679626] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.680671] NetLabel: unlabeled traffic allowed by default worker # [ 0.681642] PCI: Using ACPI for IRQ routing worker # [ 0.683255] pci 0000:00:02.0: vgaarb: setting as boot VGA device worker # [ 0.683622] pci 0000:00:02.0: vgaarb: bridge control possible worker # [ 0.683622] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.683629] vgaarb: loaded worker # [ 0.684770] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.685627] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.690708] clocksource: Switched to clocksource kvm-clock worker # [ 0.694719] VFS: Disk quotas dquot_6.6.0 worker # [ 0.695975] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.698211] pnp: PnP ACPI init worker # [ 0.699874] pnp: PnP ACPI: found 6 devices worker # [ 0.708110] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.710675] clocksource: Switched to clocksource acpi_pm worker # [ 0.712412] NET: Registered PF_INET protocol family worker # [ 0.714220] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.732575] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.735237] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.737505] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.739910] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) worker # [ 0.742091] TCP: Hash tables configured (established 16384 bind 16384) worker # [ 0.744071] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) worker # [ 0.746290] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.748253] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.750385] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.752066] NET: Registered PF_XDP protocol family worker # [ 0.753576] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.755410] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.757194] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.759182] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] worker # [ 0.761177] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] worker # [ 0.763305] pci 0000:00:01.0: PIIX3: Enabling Passive Release worker # [ 0.765049] pci 0000:00:00.0: Limiting direct PCI/PCI transfers worker # [ 0.768363] ACPI: \_SB_.LNKD: Enabled at IRQ 11 worker # [ 0.771739] PCI: CLS 0 bytes, default 64 worker # [ 0.773300] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns worker # [ 0.776265] Trying to unpack rootfs image as initramfs... worker # [ 0.825248] Initialise system trusted keyrings worker # [ 0.829882] workingset: timestamp_bits=40 max_order=19 bucket_order=0 worker # [ 0.852237] Key type asymmetric registered hub # [ 3.873282] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 0.855852] Asymmetric key parser 'x509' registered worker # [ 0.857387] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 3.882712] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 0.864982] io scheduler mq-deadline registered worker # [ 0.867847] io scheduler kyber registered worker # [ 0.872852] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 3.894202] systemd[1]: Mounting /sysroot/run... worker # [ 0.877137] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.885983] Linux agpgart interface v0.103 worker # [ 0.887324] ACPI: bus type drm_connector registered hub # [ 3.908226] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 0.893355] usbcore: registered new interface driver usbserial_generic worker # [ 0.895254] usbserial: USB Serial support registered for generic worker # [ 0.899864] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 3.923197] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 0.899864] Please enable it if your BIOS has the CPPC option. worker # [ 0.903785] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.911979] drop_monitor: Initializing network drop monitor service worker # [ 0.913996] NET: Registered PF_INET6 protocol family worker # [ 0.919944] Segment Routing with IPv6 worker # [ 0.921155] In-situ OAM (IOAM) with IPv6 worker # [ 0.925211] IPI shorthand broadcast: enabled hub # [ 4.195492] 9p: Installing v9fs 9p2000 file system support worker # [ 0.934000] sched_clock: Marking stable (695028418, 238793477)->(1124277358, -190455463) worker # [ 0.942037] registered taskstats version 1 hub # [ 3.965706] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 0.943605] Loading compiled-in X.509 certificates hub # [ 3.971307] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.975821] systemd[1]: Mounted /sysroot/run. hub # [ 3.978957] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.980654] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 0.965678] Demotion targets for Node 0: null hub # [ 3.987722] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.969000] Key type .fscrypt registered worker # [ 0.971837] Key type fscrypt-provisioning registered worker # [ 0.973459] ima: No TPM chip found, activating TPM-bypass! hub # [ 3.999071] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.978845] ima: Allocated hash algorithm: sha1 hub # [ 4.002095] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.980282] ima: No architecture policies found worker # [ 0.984010] PM: Magic number: 2:70:677 worker # [ 0.988178] RAS: Correctable Errors collector initialized. worker # [ 0.999695] clk: Disabling unused clocks worker # [ 1.002843] PM: genpd: Disabling unused power domains worker # [ 1.138949] Freeing initrd memory: 29528K worker # [ 1.142724] Freeing unused decrypted memory: 2028K worker # [ 1.146117] Freeing unused kernel image (initmem) memory: 3636K worker # [ 1.147993] Write protecting the kernel read-only data: 32768k worker # [ 1.150728] Freeing unused kernel image (text/rodata gap) memory: 1272K worker # [ 1.153222] Freeing unused kernel image (rodata/data gap) memory: 796K worker # [ 1.206184] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.208149] Run /init as init process worker # [ 1.219415] systemd[1]: Inserted module 'autofs4' worker # [ 1.236205] fuse: init (API version 7.45) worker # [ 1.243739] ACPI: \_SB_.LNKC: Enabled at IRQ 10 worker # [ 1.252488] ACPI: \_SB_.LNKA: Enabled at IRQ 10 worker # [ 1.257042] ACPI: \_SB_.LNKB: Enabled at IRQ 11 worker # [ 1.296766] systemd[1]: Successfully made /usr/ read-only. worker # [ 1.636462] 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.658004] systemd[1]: Detected virtualization kvm. worker # [ 1.661997] systemd[1]: Detected architecture x86-64. worker # [ 1.665906] systemd[1]: Running in initrd. worker # [ 1.669961] systemd[1]: Initializing machine ID from random generator. worker # [ 1.675085] systemd[1]: Hostname set to . hub # [ 4.873406] systemd[1]: Mounting /sysroot/nix/store... worker # [ 1.893344] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 4.925559] systemd[1]: Mounted /sysroot/nix/store. hub # [ 4.928131] systemd[1]: Reached target Initrd File Systems. hub # [ 4.934274] systemd[1]: Starting Find NixOS closure... hub # [ 4.940111] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 4.963150] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 4.966918] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 1.953541] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 4.976770] systemd[1]: Finished Find NixOS closure. hub # [ 4.979303] systemd[1]: Reached target Initrd Default Target. hub # [ 4.981579] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 1.959500] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.961562] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.964025] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.966053] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.968006] systemd[1]: Reached target Path Units. worker # [ 1.969548] systemd[1]: Reached target Slice Units. worker # [ 1.971141] systemd[1]: Reached target Swaps. worker # [ 1.972652] systemd[1]: Reached target Timer Units. worker # [ 1.974439] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 4.998429] systemd[1]: Stopped target Initrd Default Target. worker # [ 1.976537] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 4.999961] systemd[1]: Stopped target Basic System. worker # [ 1.978568] systemd[1]: Listening on Journal Sockets. hub # [ 5.001353] systemd[1]: Stopped target Initrd Root Device. worker # [ 1.980337] systemd[1]: Listening on udev Control Socket. hub # [ 5.002812] systemd[1]: Stopped target Path Units. worker # [ 1.982110] systemd[1]: Listening on udev Kernel Socket. hub # [ 5.004181] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 1.983858] systemd[1]: Reached target Socket Units. hub # [ 5.006615] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 1.986535] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 5.009324] systemd[1]: Stopped target Slice Units. hub # [ 5.010701] systemd[1]: Stopped target Socket Units. hub # [ 5.013203] systemd[1]: Stopped target System Initialization. hub # [ 5.014836] systemd[1]: Stopped target Swaps. worker # [ 1.993042] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 5.016116] systemd[1]: Stopped target Timer Units. hub # [ 5.017475] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 5.019669] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 5.021553] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 5.024231] systemd[1]: Stopped Find NixOS closure. worker # [ 2.004027] systemd[1]: Starting Load Kernel Module configfs... hub # [ 5.025592] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 5.028592] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 5.030900] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 5.033212] systemd[1]: Stopped Apply Kernel Variables. hub # [ 5.034872] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 5.037197] systemd[1]: Stopped Load Kernel Modules. hub # [ 5.039257] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 2.017921] systemd[1]: Starting Journal Service... hub # [ 5.041255] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 5.044044] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 5.046589] systemd[1]: Stopped Create System Files and Directories. hub # [ 5.048262] systemd[1]: Stopped target Local File Systems. hub # [ 5.051179] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 5.052940] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 5.055232] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 5.057549] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 2.035975] systemd[1]: Starting Load Kernel Modules... hub # [ 5.060478] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 5.063435] systemd[1]: Stopped Virtual Console Setup. hub # [ 5.074145] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 2.040975] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.056210] netfs: FS-Cache loaded hub # [ 5.080845] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 2.061577] 9pnet: Installing 9P2000 support hub # [ 5.084987] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 5.087174] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 5.089688] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 5.092286] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 5.096796] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 5.098783] systemd[1]: Closed udev Control Socket. worker # [ 2.076525] systemd[1]: Starting Coldplug All udev Devices... hub # [ 5.101209] systemd[1]: Starting Cleanup udev Database... hub # [ 5.103155] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 5.105969] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 5.107637] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 5.109642] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 5.112228] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 2.090536] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 5.114052] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 2.095971] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.105593] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 5.129681] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 5.132473] systemd[1]: Finished Cleanup udev Database. hub # [ 5.134712] systemd[1]: Reached target Switch Root. hub # [ 5.137784] systemd[1]: Starting NixOS Activation... worker # [ 2.117905] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.122675] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.130385] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.138476] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.142961] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.148578] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.166070] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 2.189914] systemd[1]: Finished Load Kernel Modules. worker # [ 2.202937] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.220960] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.234285] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.251522] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.275003] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.281195] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.287938] systemd[1]: Reached target Local File Systems. hub # [ 5.312056] initrd-nixos-activation-start[180]: booting system configuration /nix/store/zgzkwzc0py7zqi6y54rgz8qp7jlgacvz-nixos-system-hub-test worker # [ 2.297134] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.061185] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 2.064647] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 2.066629] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.315061] systemd[1]: Started Journal Service. worker # [ 2.101138] systemd[1]: Starting Create System Files and Directories... hub # [ 5.383598] initrd-nixos-activation-start[180]: running activation script... worker # [ 2.133345] systemd-udevd[75]: Using default interface naming scheme 'v261'. worker # [ 2.139125] systemd[1]: Finished Create System Files and Directories. worker # [ 2.171110] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.223154] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.224772] systemd[1]: Reached target System Initialization. worker # [ 2.226334] systemd[1]: Reached target Basic System. worker # [ 2.757453] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.782251] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.787442] uhci_hcd 0000:00:01.2: UHCI Host Controller worker # [ 2.808118] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.811951] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 hub # [ 5.841701] initrd-nixos-activation-start[203]: setting up /etc... worker # [ 2.828596] uhci_hcd 0000:00:01.2: detected 2 ports worker # [ 2.832637] SCSI subsystem initialized worker # [ 2.838271] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.841311] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c140 worker # [ 2.851118] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # [ 2.858640] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.877303] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.892379] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.657111] systemd[1]: Starting Virtual Console Setup... worker # [ 2.902839] usb usb1: Product: UHCI Host Controller worker # [ 2.672308] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.920829] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd worker # [ 2.928547] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.694104] (udev-worker)[88]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.697756] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.705378] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.711308] systemd[1]: Finished Virtual Console Setup. worker # [ 2.953843] virtio_blk virtio5: [vdb] 2081880 512-byte logical blocks (1.07 GB/1017 MiB) worker # [ 2.955733] usb usb1: SerialNumber: 0000:00:01.2 worker # [ 2.967405] hub 1-0:1.0: USB hub found worker # [ 2.972512] hub 1-0:1.0: 2 ports detected worker # [ 3.017376] scsi host0: ata_piix worker # [ 3.022419] scsi host1: ata_piix worker # [ 3.027012] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 0 worker # [ 2.793841] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 3.036929] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 0 worker # [ 2.803171] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.806533] systemd[1]: Reached target Initrd Root Device. worker # [ 2.808785] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.831428] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.839283] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.852543] systemd[1]: Mounting /sysroot... hub # [ 6.145214] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 6.147336] systemd[1]: Finished NixOS Activation. hub # [ 6.150217] systemd[1]: Starting Switch Root... hub # [ 6.164392] systemd[1]: Switching root. worker # [ 3.197108] ata2: found unknown device (class 0) worker # [ 3.199251] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.202528] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.205843] usb 1-1: new full-speed USB device number 2 using uhci_hcd worker # [ 3.256577] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.273242] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 6.535182] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 3.294487] EXT4-fs (vda): mounted filesystem 222ce66b-4f53-48b8-af0b-d72e1bbec002 r/w with ordered data mode. Quota mode: none. worker # [ 3.061795] systemd[1]: Mounted /sysroot. worker # [ 3.066102] systemd[1]: Reached target Initrd Root File System. worker # [ 3.070108] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 3.084589] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.093108] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.095793] systemd[1]: Reloading... worker # [ 3.375037] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.376995] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.382710] usb 1-1: Product: QEMU USB Tablet worker # [ 3.385833] usb 1-1: Manufacturer: QEMU worker # [ 3.387731] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 3.429550] hid: raw HID events driver (C) Jiri Kosina hub # [ 6.698981] NET: Registered PF_VSOCK protocol family worker # [ 3.452544] usbcore: registered new interface driver usbhid worker # [ 3.457925] usbhid: USB HID core driver worker # [ 3.468051] 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.474959] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 worker # [ 3.256480] systemd[1]: Reloading finished in 163 ms. worker # [ 3.266934] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace... worker # [ 3.277247] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace... worker # [ 3.281806] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.284304] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.287104] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.290429] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 7.087210] 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 # [ 7.103334] systemd[1]: Detected virtualization kvm. hub # [ 7.106519] systemd[1]: Detected architecture x86-64. hub # [ 7.109810] systemd[1]: Detected first boot. hub # [ 7.117660] systemd[1]: Initializing machine ID from random generator. worker # [ 3.855283] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 7.360689] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 3.864273] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.876407] systemd[1]: Mounting /sysroot/run... worker # [ 3.888472] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.903721] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 3.937402] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.950217] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 4.193875] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 4.201001] 9p: Installing v9fs 9p2000 file system support worker # [ 3.964658] systemd[1]: Mounted /sysroot/run. worker # [ 3.973481] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.981698] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.985224] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.989103] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.991752] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 7.499670] systemd[1]: Applying preset policy. hub # [ 8.050405] systemd[1]: Populated /etc with preset unit settings. worker # [ 4.854951] systemd[1]: Mounting /sysroot/nix/store... worker # [ 4.906581] systemd[1]: Mounted /sysroot/nix/store. worker # [ 4.908723] systemd[1]: Reached target Initrd File Systems. worker # [ 4.912221] systemd[1]: Starting Find NixOS closure... worker # [ 4.918764] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 4.941344] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 4.946123] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 4.955105] systemd[1]: Finished Find NixOS closure. worker # [ 4.957275] systemd[1]: Reached target Initrd Default Target. worker # [ 4.959749] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 4.975292] systemd[1]: Stopped target Initrd Default Target. worker # [ 4.978093] systemd[1]: Stopped target Basic System. worker # [ 4.979479] systemd[1]: Stopped target Initrd Root Device. worker # [ 4.980970] systemd[1]: Stopped target Path Units. worker # [ 4.982703] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 4.984966] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 4.987597] systemd[1]: Stopped target Slice Units. worker # [ 4.990382] systemd[1]: Stopped target Socket Units. worker # [ 4.991770] systemd[1]: Stopped target System Initialization. worker # [ 4.993312] systemd[1]: Stopped target Swaps. worker # [ 4.994722] systemd[1]: Stopped target Timer Units. worker # [ 4.996727] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.998323] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 5.000293] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 5.003248] systemd[1]: Stopped Find NixOS closure. worker # [ 5.004611] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 5.007335] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 5.010186] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 5.011922] systemd[1]: Stopped Apply Kernel Variables. worker # [ 5.013492] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 5.015343] systemd[1]: Stopped Load Kernel Modules. worker # [ 5.018235] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 5.020265] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 5.022260] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 5.024153] systemd[1]: Stopped Create System Files and Directories. worker # [ 5.025759] systemd[1]: Stopped target Local File Systems. worker # [ 5.027872] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 5.030232] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 5.033306] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 5.035711] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 5.037602] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 5.040163] systemd[1]: Stopped Virtual Console Setup. worker # [ 5.056191] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 5.061321] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 5.063172] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 5.066115] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 5.068328] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 5.070799] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 5.074673] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 5.076701] systemd[1]: Closed udev Control Socket. worker # [ 5.079198] systemd[1]: Starting Cleanup udev Database... worker # [ 5.080816] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 5.083100] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 5.084727] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 5.087192] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 5.089217] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 5.092204] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 5.109931] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 5.112178] systemd[1]: Finished Cleanup udev Database. worker # [ 5.114392] systemd[1]: Reached target Switch Root. worker # [ 5.116835] systemd[1]: Starting NixOS Activation... hub # [ 8.638686] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 8.641209] systemd[1]: Stopped initrd-switch-root.service. hub # [ 8.645114] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 8.648273] systemd[1]: Created slice Slice /system/getty. hub # [ 8.650321] systemd[1]: Created slice User and Session Slice. hub # [ 8.651848] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 8.654031] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 8.655832] systemd[1]: Expecting device /dev/hvc0... hub # [ 8.657110] systemd[1]: Expecting device /dev/ttyS0... hub # [ 8.658417] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 8.659844] systemd[1]: Stopped target initrd-fs.target. hub # [ 8.661199] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 8.662598] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 8.664135] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 8.665709] systemd[1]: Reached target Path Units. hub # [ 8.666992] systemd[1]: Reached target Remote File Systems. hub # [ 8.668378] systemd[1]: Reached target Slice Units. hub # [ 8.669643] systemd[1]: Reached target Swaps. worker # [ 5.171335] initrd-nixos-activation-start[183]: booting system configuration /nix/store/jfblc23in63zx144sr9kfhfhdc5fyhn9-nixos-system-worker-test hub # [ 8.674438] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 8.679988] systemd[1]: Listening on Process Core Dump Socket. hub # [ 8.684324] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 8.688566] systemd[1]: Listening on Factory Reset Management. hub # [ 8.690195] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.191525] initrd-nixos-activation-start[183]: running activation script... hub # [ 8.695612] systemd[1]: Starting Journal Log Access Socket... hub # [ 8.698043] systemd[1]: Listening on Journal Audit Socket. hub # [ 8.702271] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 8.704292] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 8.706794] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 8.708999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 8.723511] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 8.725299] systemd[1]: Listening on udev Control Socket. hub # [ 8.726825] systemd[1]: Listening on udev Varlink Socket. hub # [ 8.732093] systemd[1]: Mounting Huge Pages File System... hub # [ 8.736810] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 8.744998] systemd[1]: Mounting Kernel Debug File System... hub # [ 8.753388] systemd[1]: Mounting Kernel Trace File System... hub # [ 8.762413] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 8.764446] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 8.777383] systemd[1]: Starting Load Kernel Module configfs... hub # [ 8.780016] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 8.782853] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 8.786137] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 8.796011] systemd[1]: Mounting FUSE Control File System... hub # [ 8.797505] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 5.330308] initrd-nixos-activation-start[206]: setting up /etc... hub # [ 8.831551] systemd[1]: Starting Journal Service... hub # [ 8.852593] systemd[1]: Starting Load Kernel Modules... hub # [ 8.873744] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 8.889219] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 8.896629] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.402677] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 5.406113] systemd[1]: Finished NixOS Activation. worker # [ 5.408538] systemd[1]: Starting Switch Root... hub # [ 8.908331] systemd-journald[273]: Collecting audit messages is enabled. hub # [ 8.912280] systemd[1]: Starting Coldplug All udev Devices... worker # [ 5.423523] systemd[1]: Switching root. hub # [ 8.938657] systemd[1]: Listening on Journal Log Access Socket. hub # [ 8.952017] loop: module loaded hub # [ 8.956185] systemd[1]: Mounted Huge Pages File System. hub # [ 8.722579] systemd[1]: Queued start job for default target Multi-User System.[ 8.963467] systemd[1]: Started Journal Service. hub # hub # [ 8.726520] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 8.736276] systemd-modules-load[274]: Inserted module 'loop' hub # [ 8.977047] EXT4-fs (vda): re-mounted 9d58db14-b94d-4020-b2e3-aa6a859fd357. hub # [ 8.740436] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 8.746906] systemd[1]: Mounted Kernel Debug File System. hub # [ 8.748652] systemd[1]: Mounted Kernel Trace File System. hub # [ 8.756227] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 8.759335] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 8.766279] systemd[1]: Finished Load Kernel Module configfs. hub # [ 8.770232] systemd[1]: Mounted FUSE Control File System. hub # [ 8.775178] systemd-modules-load[274]: Inserted module 'tls' hub # [ 8.777619] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 8.787866] systemd[1]: Finished Load Kernel Modules. hub # [ 8.802128] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 8.811098] systemd[1]: Mounting Kernel Configuration File System... worker # [ 5.787898] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 8.819155] systemd[1]: Starting Firewall... hub # [ 8.831925] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 8.833801] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 8.839371] systemd-oomd[276]: No swap; memory pressure usage will be degraded hub # [ 8.853262] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 8.865751] systemd[1]: Starting Apply Kernel Variables... worker # [ 5.867026] NET: Registered PF_VSOCK protocol family hub # [ 8.890093] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 8.892170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 8.903887] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 9.156484] systemd-journald[273]: Received client request to flush runtime journal. hub # [ 9.132109] systemd[1]: Mounted Kernel Configuration File System. hub # [ 9.138821] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 9.143966] systemd[1]: Reached target First Boot Complete. hub # [ 9.150300] systemd[1]: Finished Apply Kernel Variables. hub # [ 9.152810] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 9.155870] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 9.158511] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 9.197724] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 9.200540] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 9.206721] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 6.223553] 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 # [ 6.239736] systemd[1]: Detected virtualization kvm. worker # [ 6.242926] systemd[1]: Detected architecture x86-64. worker # [ 6.246139] systemd[1]: Detected first boot. worker # [ 6.249946] systemd[1]: Initializing machine ID from random generator. hub # [ 9.300160] systemd[1]: Finished Coldplug All udev Devices. hub # [ 9.308577] systemd-udevd[317]: Using default interface naming scheme 'v261'. hub # [ 9.404274] systemd[1]: Mounting /run/wrappers... hub # [ 9.442426] systemd[1]: Mounted /run/wrappers. hub # [ 9.443842] systemd[1]: Reached target Local File Systems. hub # [ 9.449157] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 9.455772] systemd[1]: Starting register-nix-paths.service... hub # [ 9.461128] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 9.462694] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 9.475920] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 9.490072] systemd[1]: Starting Create System Files and Directories... hub # [ 9.495291] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 6.493680] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 9.571221] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 9.578927] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 6.609806] systemd[1]: Applying preset policy. hub # [ 9.659112] systemd[1]: Finished Create System Files and Directories. hub # [ 9.672650] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 9.686390] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 6.732431] systemd[1]: Populated /etc with preset unit settings. hub # [ 9.766907] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 9.820801] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 9.828593] systemd[1]: Starting Update is Completed... worker # [ 6.842819] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 6.845258] systemd[1]: Stopped initrd-switch-root.service. worker # [ 6.848728] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 6.852039] systemd[1]: Created slice Slice /system/getty. worker # [ 6.854114] systemd[1]: Created slice User and Session Slice. worker # [ 6.855654] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 6.857711] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 6.859573] systemd[1]: Expecting device /dev/hvc0... worker # [ 6.860905] systemd[1]: Expecting device /dev/ttyS0... worker # [ 6.862221] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 6.863668] systemd[1]: Stopped target initrd-fs.target. worker # [ 6.865025] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 6.866434] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 6.868010] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 9.890724] systemd[1]: Finished Update is Completed. worker # [ 6.869600] systemd[1]: Reached target Path Units. worker # [ 6.870886] systemd[1]: Reached target Remote File Systems. worker # [ 6.872290] systemd[1]: Reached target Slice Units. worker # [ 6.873566] systemd[1]: Reached target Swaps. worker # [ 6.875565] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 6.878357] systemd[1]: Listening on Process Core Dump Socket. worker # [ 6.880400] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 6.882677] systemd[1]: Listening on Factory Reset Management. worker # [ 6.884287] systemd[1]: Listening on Hostname Service Socket. worker # [ 6.887380] systemd[1]: Starting Journal Log Access Socket... worker # [ 6.889442] systemd[1]: Listening on Journal Audit Socket. worker # [ 6.892521] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 6.894395] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 6.896291] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.898507] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 6.902224] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 6.903995] systemd[1]: Listening on udev Control Socket. worker # [ 6.905499] systemd[1]: Listening on udev Varlink Socket. worker # [ 6.908854] systemd[1]: Mounting Huge Pages File System... worker # [ 6.914384] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 6.922921] systemd[1]: Mounting Kernel Debug File System... worker # [ 6.933448] systemd[1]: Mounting Kernel Trace File System... worker # [ 6.946410] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 6.955541] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 6.974275] systemd[1]: Starting Load Kernel Module configfs... worker # [ 6.977878] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 6.980681] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.983337] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.991368] systemd[1]: Mounting FUSE Control File System... worker # [ 6.996916] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 10.022978] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 7.007426] systemd[1]: Starting Journal Service... worker # [ 7.014412] systemd[1]: Starting Load Kernel Modules... worker # [ 7.026041] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 7.044900] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 7.053272] systemd-journald[276]: Collecting audit messages is enabled. worker # [ 7.057106] loop: module loaded worker # [ 7.060891] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 7.073276] systemd[1]: Starting Coldplug All udev Devices... worker # [ 7.090876] EXT4-fs (vda): re-mounted 222ce66b-4f53-48b8-af0b-d72e1bbec002. worker # [ 6.867744] systemd[1]: Queued start job for default target Multi-User System.[ 7.109219] systemd[1]: Started Journal Service. worker # worker # [ 6.872805] systemd[1]: Unnecessary job was removed for /dev/vdb. worker # [ 6.876681] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 6.882569] systemd-modules-load[277]: Inserted module 'loop' worker # [ 6.887595] systemd[1]: Listening on Journal Log Access Socket. worker # [ 6.889564] systemd[1]: Mounted Huge Pages File System. worker # [ 6.894986] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 6.896915] systemd[1]: Mounted Kernel Debug File System. worker # [ 6.902897] systemd[1]: Mounted Kernel Trace File System. worker # [ 6.904681] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 6.910770] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 6.912817] systemd[1]: Finished Load Kernel Module configfs. worker # [ 6.916249] systemd[1]: Mounted FUSE Control File System. worker # [ 6.919262] systemd[1]: Finished Load Kernel Modules. worker # [ 6.923370] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 10.191093] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 10.192962] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 6.945115] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 6.947970] systemd-oomd[279]: No swap; memory pressure usage will be degraded worker # [ 6.953118] systemd[1]: Mounting Kernel Configuration File System... worker # [ 6.964098] systemd[1]: Starting Firewall... worker # [ 6.975104] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 6.976844] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 10.247408] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 6.990112] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 7.003146] systemd[1]: Starting Apply Kernel Variables... worker # [ 7.020453] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 7.024739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 7.026929] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 10.301675] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 7.300394] systemd-journald[276]: Received client request to flush runtime journal. hub # [ 10.352050] (udev-worker)[391]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 10.358395] (udev-worker)[391]: Network interface NamePolicy= disabled on kernel command line. hub # [ 10.360766] (udev-worker)[393]: Network interface NamePolicy= disabled on kernel command line. hub # [ 10.495921] systemd[1]: Finished register-nix-paths.service. hub # [ 10.498541] systemd[1]: Reached target System Initialization. hub # [ 10.503569] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 10.506077] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 10.508228] systemd[1]: Reached target Timer Units. hub # [ 10.511670] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 10.513411] systemd[1]: Listening on Nix Daemon Socket. hub # [ 10.516214] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 10.519208] systemd[1]: Reached target Socket Units. hub # [ 10.521491] systemd[1]: Reached target Basic System. hub # [ 10.527139] systemd[1]: Started backdoor.service. hub # [ 10.532452] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 10.548325] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 10.560750] systemd[1]: Starting Post-Boot Actions... worker # [ 7.305158] systemd[1]: Mounted Kernel Configuration File System. worker # [ 7.312512] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 7.315384] systemd[1]: Reached target First Boot Complete. worker # [ 7.318619] systemd[1]: Finished Apply Kernel Variables. worker # [ 7.322489] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 10.587386] systemd[1]: Started Reset console on configuration changes. worker # [ 7.328731] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 7.331270] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 7.335427] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 7.338279] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 7.341596] systemd-udevd[316]: Using default interface naming scheme 'v261'. worker # [ 7.344634] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 10.613675] systemd[1]: Starting resolvconf update... hub # [ 10.655666] systemd[1]: Finished Firewall. worker # [ 7.398630] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # connecting to host... hub # [ 10.678274] systemd[1]: Finished Post-Boot Actions. hub # [ 10.708554] systemd[1]: Condition check resulted in Virtio network device being skipped. hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub # [ 10.722577] systemd[1]: Starting D-Bus System Message Bus... hub: (connecting took 8.38 seconds) hub # [ 10.725092] systemd[1]: Started Name Service Cache Daemon (nsncd). hub: (finished: waiting for the VM to finish booting, in 8.38 seconds) hub # [ 10.730134] nsncd[503]: Jul 13 09:40:04.687 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.471832] systemd[1]: Finished Coldplug All udev Devices. hub # [ 10.733574] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 10.735238] systemd[1]: Reached target User and Group Name Lookups. hub # [ 10.762531] systemd[1]: Starting User Login Management... hub # [ 10.768374] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 7.612184] systemd[1]: Mounting /run/wrappers... worker # [ 7.642527] systemd[1]: Mounted /run/wrappers. worker # [ 7.644871] systemd[1]: Reached target Local File Systems. worker # [ 7.651110] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 7.657666] systemd[1]: Starting register-nix-paths.service... hub # [ 10.926560] dbus-broker-launch[534]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 7.666544] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 7.669188] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 10.930477] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 10.934604] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 10.938973] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 10.941716] systemd[1]: Stopping User and Group Name Lookups... hub # [ 10.943297] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 7.688124] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 10.949065] systemd[1]: nscd.service: Deactivated successfully. hub # [ 10.952192] dbus-broker-launch[534]: NSS returned no entry for 'systemd-timesync' hub # [ 10.954408] dbus-broker-launch[534]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" hub # [ 10.959378] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 7.703104] systemd[1]: Starting Create System Files and Directories... worker # [ 7.717221] systemd[1]: Finished Firewall. hub # [ 10.980244] systemd-logind[538]: New seat seat0. hub # [ 10.986111] systemd[1]: Started User Login Management. hub # [ 10.995282] systemd[1]: Starting linger-users.service... hub # [ 11.007958] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 11.012802] systemd[1]: Started D-Bus System Message Bus. worker # [ 7.759125] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 7.772149] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 11.053296] dbus-broker-launch[534]: Ready worker # [ 7.792114] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 7.828302] systemd[1]: Finished Create System Files and Directories. worker # [ 7.841471] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 11.102370] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 11.106417] systemd[1]: Finished linger-users.service. hub # [ 11.110833] nsncd[589]: Jul 13 09:40:05.079 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 11.116211] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.859116] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 11.121159] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 11.122960] systemd[1]: Reached target User and Group Name Lookups. hub # [ 11.366708] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 11.150329] systemd[1]: Finished resolvconf update. hub # [ 11.152224] systemd[1]: Reached target Preparation for Network. hub # [ 11.162161] systemd[1]: Starting DHCP Client... hub # [ 11.167247] systemd[1]: Starting Address configuration of eth1... hub # [ 11.179764] systemd[1]: Starting Extra networking commands.... worker # [ 7.928532] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 11.198116] systemd[1]: Starting Tailscale node agent... hub # [ 11.471155] ACPI: button: Power Button [PWRF] worker # [ 7.974667] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.984968] systemd[1]: Starting Update is Completed... worker # [ 8.036281] systemd[1]: Finished Update is Completed. hub # [ 11.554612] rtc_cmos 00:05: RTC can wake from S4 hub # [ 11.560729] mousedev: PS/2 mouse device common for all mice hub # [ 11.328550] network-addresses-eth1-start[615]: adding address 192.168.1.1/24... done worker # [ 8.094844] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. hub # [ 11.356687] network-addresses-eth1-start[615]: adding address 2001:db8:1::1/64... done hub # [ 11.611646] rtc_cmos 00:05: registered as rtc0 hub # [ 11.620378] rtc_cmos 00:05: setting system clock to 2026-07-13T09:40:05 UTC (1783935605) hub # [ 11.396658] systemd[1]: Finished Address configuration of eth1. hub # [ 11.637635] parport_pc 00:03: reported by Plug and Play ACPI worker # [ 8.147358] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 11.647526] Floppy drive(s): fd0 is 2.88M AMI BIOS worker # [ 8.151107] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 8.192589] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 11.695784] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 11.704777] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 8.207609] (udev-worker)[387]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 8.226880] (udev-worker)[387]: Network interface NamePolicy= disabled on kernel command line. hub # [ 11.491890] dhcpcd[629]: dhcpcd-10.3.2 starting worker # [ 8.233421] (udev-worker)[394]: Network interface NamePolicy= disabled on kernel command line. hub # [ 11.742618] FDC 0 is a S82078B hub # [ 11.517245] dhcpcd[680]: dev: loaded udev hub # [ 11.522624] systemd[1]: Finished Extra networking commands.. hub # [ 11.526397] systemd[1]: Reached target Network. hub # [ 11.537347] systemd[1]: Starting Nginx Web Server... hub # [ 11.553064] systemd[1]: Starting Permit User Sessions... hub # [ 11.795798] 8021q: 802.1Q VLAN Support v1.8 hub # [ 11.800946] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.312367] systemd[1]: Finished register-nix-paths.service. worker # [ 8.316277] systemd[1]: Reached target System Initialization. worker # [ 8.319117] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 8.320952] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 8.323774] systemd[1]: Reached target Timer Units. worker # [ 8.326272] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 8.328431] systemd[1]: Listening on Nix Daemon Socket. worker # [ 8.331331] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 8.333782] systemd[1]: Listening on tribuchet-sandboxd.socket. worker # [ 8.335937] systemd[1]: Reached target Socket Units. worker # [ 8.338234] systemd[1]: Reached target Basic System. worker # [ 8.340664] systemd[1]: Started backdoor.service. worker # [ 8.349208] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 8.358109] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 8.370638] systemd[1]: Starting Post-Boot Actions... hub # [ 11.638328] systemd[1]: Finished Permit User Sessions. worker # [ 8.384817] systemd[1]: Started Reset console on configuration changes. hub # [ 11.651551] systemd[1]: Started Getty on tty1. hub # [ 11.655937] systemd[1]: Reached target Login Prompts. worker # connecting to host... worker # [ 8.411106] systemd[1]: Starting resolvconf update... hub # [ 11.917344] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 hub # [ 11.934438] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 8.447170] systemd[1]: Finished Post-Boot Actions. hub # [ 11.708416] tailscaled[618]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 8.465586] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 8.468781] nsncd[504]: Jul 13 09:40:05.701 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 11.745489] tailscaled[618]: logtail started worker # [ 8.488761] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 11.747731] tailscaled[618]: 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 # [ 11.755141] tailscaled[618]: LogID: 9e31a15b69986d70ea3409418b77416e2da4de2f74523017bc51d1b750aa0d0e worker # [ 8.496340] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 11.757988] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 11.760344] tailscaled[618]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 8.504109] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 11.764602] tailscaled[618]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 8.505773] systemd[1]: Reached target User and Group Name Lookups. worker # [ 8.512109] systemd[1]: Starting D-Bus System Message Bus... worker # [ 8.534794] systemd[1]: Starting User Login Management... hub # [ 11.826892] dbus-broker-launch[534]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. hub # [ 11.836876] tailscaled[618]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:42916->[::1]:53: read: connection refused (in 43ms), trying bootstrap... hub # [ 11.855868] tailscaled[618]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... hub # [ 11.862178] tailscaled[618]: bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.134:443: connect: network is unreachable hub # [ 11.866814] tailscaled[618]: trying bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" ... worker # [ 8.610368] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 11.869382] tailscaled[618]: bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::e08:e001]:443: connect: network is unreachable hub # [ 11.875220] tailscaled[618]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... worker # [ 8.615899] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync' hub # [ 11.877745] tailscaled[618]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable worker # [ 8.618461] dbus-broker-launch[530]: Invalid user-name in /nix/store/a7agjv2209jvj4cvwy8lz4g35l9gak1c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" hub # [ 11.884183] tailscaled[618]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ... worker # [ 8.631163] systemd[1]: Started D-Bus System Message Bus. hub # [ 11.890131] tailscaled[618]: bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::287]:443: connect: network is unreachable hub # [ 11.894948] tailscaled[618]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ... hub # [ 11.897468] tailscaled[618]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable hub # [ 11.903086] tailscaled[618]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... hub # [ 11.905883] tailscaled[618]: 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 # [ 11.912196] tailscaled[618]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... hub # [ 11.915487] tailscaled[618]: bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.134:443: connect: network is unreachable hub # [ 11.921832] tailscaled[618]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ... worker # [ 8.663338] dbus-broker-launch[530]: Ready hub # [ 11.925541] tailscaled[618]: bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:b001]:443: connect: network is unreachable hub # [ 11.931537] tailscaled[618]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ... hub # [ 11.934273] tailscaled[618]: bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 144.202.67.195:443: connect: network is unreachable worker # [ 8.678579] systemd-logind[534]: New seat seat0. hub # [ 11.939272] tailscaled[618]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... worker # [ 8.683258] systemd[1]: Started User Login Management. hub # [ 11.942975] tailscaled[618]: bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7a0:e001]:443: connect: network is unreachable hub # [ 11.948646] tailscaled[618]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... hub # [ 11.951533] tailscaled[618]: bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.74.153:443: connect: network is unreachable worker # [ 8.698398] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 11.958110] tailscaled[618]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... worker # [ 8.702170] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 8.703780] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 11.961430] tailscaled[618]: 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 # [ 8.706562] systemd[1]: Stopping User and Group Name Lookups... worker # [ 8.710139] systemd[1]: Starting linger-users.service... hub # [ 11.967417] tailscaled[618]: logtail: upload: log upload of 479 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/68f2530c56a968c05b0a96bcaf9ef75a0fef1218d3982eceb658dc95183b6572": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 8.714759] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 8.721140] systemd[1]: nscd.service: Deactivated successfully. worker # [ 8.727240] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 8.731125] systemd[1]: nscd.service: Consumed 17ms CPU time over 362ms wall clock time, 6.8M memory peak, 5.5M read from disk. hub # [ 12.009357] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 12.011292] tailscaled[618]: dns: using "openresolv" mode worker # [ 8.756111] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 12.019512] tailscaled[618]: dns: using dns.openresolvManager worker # [ 8.776950] systemd[1]: Finished resolvconf update. worker # [ 8.778405] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 8.784139] systemd[1]: Finished linger-users.service. worker # [ 8.793542] systemd[1]: Reached target Preparation for Network. worker # [ 8.802923] systemd[1]: Starting DHCP Client... worker # [ 8.807396] nsncd[584]: Jul 13 09:40:06.040 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 8.816646] systemd[1]: Starting Address configuration of eth1... worker # [ 9.063868] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 8.828344] systemd[1]: Starting Extra networking commands.... hub # [ 12.093706] nginx-pre-start[692]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok worker # [ 8.839356] systemd[1]: Starting Tailscale node agent... hub # [ 12.099137] nginx-pre-start[692]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful worker # [ 8.850156] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 12.116976] systemd[1]: Started Nginx Web Server. worker # [ 8.863128] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 8.864774] systemd[1]: Reached target User and Group Name Lookups. worker # [ 8.915896] network-addresses-eth1-start[600]: adding address 192.168.1.2/24... done hub # [ 12.097422] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 8.938146] network-addresses-eth1-start[600]: adding address 2001:db8:1::2/64... done worker # [ 8.967076] systemd[1]: Finished Address configuration of eth1. hub # [ 12.098374] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 hub # [ 12.163665] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 9.260006] rtc_cmos 00:05: RTC can wake from S4 worker # [ 9.276004] ACPI: button: Power Button [PWRF] hub # [ 12.251764] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 12.251925] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 12.312769] systemd[1]: Starting Virtual Console Setup... hub # [ 12.253970] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 12.253978] cfg80211: failed to load regulatory.db hub # [ 12.265546] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 12.265988] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 12.418139] Console: switching to colour dummy device 80x25 hub # [ 12.598244] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 12.598247] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 12.601133] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic hub # [ 12.620942] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 9.123304] dhcpcd[623]: dhcpcd-10.3.2 starting worker # [ 9.127742] systemd[1]: Finished Extra networking commands.. worker # [ 9.133134] systemd[1]: Reached target Network. worker # [ 9.134665] dhcpcd[665]: dev: loaded udev worker # [ 9.146114] systemd[1]: Starting Permit User Sessions... worker # [ 9.387883] mousedev: PS/2 mouse device common for all mice worker # [ 9.390502] 8021q: 802.1Q VLAN Support v1.8 worker # [ 9.391573] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 12.645924] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 9.409330] rtc_cmos 00:05: registered as rtc0 worker # [ 9.414791] parport_pc 00:03: reported by Plug and Play ACPI hub # [ 12.669208] Console: switching to colour frame buffer device 160x50 worker # [ 9.418313] Floppy drive(s): fd0 is 2.88M AMI BIOS hub # [ 12.681598] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 9.422065] rtc_cmos 00:05: setting system clock to 2026-07-13T09:40:06 UTC (1783935606) worker # [ 9.207259] systemd[1]: Finished Permit User Sessions. worker # [ 9.219501] systemd[1]: Started Getty on tty1. worker # [ 9.220784] systemd[1]: Reached target Login Prompts. hub # [ 12.486812] systemd[1]: Started Tailscale node agent. worker # [ 9.225920] tailscaled[602]: TPM: error opening: stat /dev/tpmrm0: no such file or directory hub # [ 12.489193] tailscaled[618]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 9.472368] FDC 0 is a S82078B worker # [ 9.236848] tailscaled[602]: logtail started worker # [ 9.238100] tailscaled[602]: 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.243281] tailscaled[602]: LogID: a9b463678bb5b65ca84b58e010480d4bc1926eae5131ef762a34e1ede58a1016 worker # [ 9.245368] tailscaled[602]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 9.247765] tailscaled[602]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 9.251055] tailscaled[602]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 9.495970] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 12.768479] tun: Universal TUN/TAP device driver, 1.6 worker # [ 9.508558] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 12.775354] kvm_amd: TSC scaling supported worker # [ 9.274115] tailscaled[602]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:58857->[::1]:53: read: connection refused (in 12ms), trying bootstrap... hub # [ 12.776680] kvm_amd: Nested Virtualization enabled hub # [ 12.779574] kvm_amd: Nested Paging enabled hub # [ 12.783800] kvm_amd: LBR virtualization supported worker # [ 9.283110] tailscaled[602]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ... hub # [ 12.785470] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 12.788376] kvm_amd: Virtual GIF supported worker # [ 9.285645] tailscaled[602]: 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 hub # [ 12.789732] kvm_amd: Virtual NMI enabled worker # [ 9.296774] tailscaled[602]: trying bootstrapDNS("derp10.tailscale.com", "2001:19f0:8001:2d9:5400:2ff:feef:bbb1") for "log.tailscale.com" ... worker # [ 9.300427] dbus-broker-launch[530]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 9.307785] tailscaled[602]: 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 worker # [ 9.313112] tailscaled[602]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ... worker # [ 9.320207] tailscaled[602]: bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 104.248.8.210:443: connect: network is unreachable worker # [ 9.328112] tailscaled[602]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... hub # [ 12.592241] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 12.594363] tailscaled[618]: dns: using "openresolv" mode worker # [ 9.330732] tailscaled[602]: 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 # [ 9.335902] tailscaled[602]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ... worker # [ 9.338266] tailscaled[602]: bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" error: Get "https://derp10.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 137.220.36.168:443: connect: network is unreachable worker # [ 9.345131] tailscaled[602]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... hub # [ 12.613293] tailscaled[618]: dns: using dns.openresolvManager worker # [ 9.349207] tailscaled[602]: 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 # [ 12.615569] tailscaled[618]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} worker # [ 9.358226] tailscaled[602]: trying bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" ... worker # [ 9.364108] tailscaled[602]: 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 hub # [ 12.631626] tailscaled[618]: magicsock: disco key = d:2a3dc5d3af0b735e worker # [ 9.372124] tailscaled[602]: trying bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" ... hub # [ 12.634141] tailscaled[618]: Creating WireGuard device... hub # [ 12.638384] tailscaled[618]: Bringing WireGuard device up... worker # [ 9.374747] tailscaled[602]: bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:6001]:443: connect: network is unreachable worker # [ 9.379645] tailscaled[602]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... worker # [ 9.382065] tailscaled[602]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable worker # [ 9.389130] tailscaled[602]: trying bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" ... worker # [ 9.391694] tailscaled[602]: bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::ec1:e001]:443: connect: network is unreachable worker # [ 9.396588] tailscaled[602]: trying bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" ... hub # [ 12.658558] tailscaled[618]: Bringing router up... hub # [ 12.660877] tailscaled[618]: router: using firewall mode pref worker # [ 9.398948] tailscaled[602]: bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 165.22.33.71:443: connect: network is unreachable worker # [ 9.404337] tailscaled[602]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... hub # [ 12.667736] tailscaled[618]: external route: up hub # [ 12.669427] tailscaled[618]: router: portUpdate(port=41641, network=udp6) worker # [ 9.413214] tailscaled[602]: 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 # [ 9.419173] tailscaled[602]: logtail: upload: log upload of 476 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/98d9495f9a6cd78a11a9d2601493c59363927510f41e6f00cf5446f7e39ecb6e": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" hub # [ 12.927538] EDAC MC: Ver: 3.0.0 worker # [ 9.667961] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 9.437099] tailscaled[602]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 9.438985] tailscaled[602]: dns: using "openresolv" mode worker # [ 9.441388] tailscaled[602]: dns: using dns.openresolvManager worker # [ 9.683063] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 hub # [ 12.724979] tailscaled[618]: router: default choosing iptables hub # [ 12.776391] tailscaled[618]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 12.785079] tailscaled[618]: Clearing router settings... hub # [ 12.786834] tailscaled[618]: Starting network monitor... hub # [ 12.791327] tailscaled[618]: Engine created. hub # [ 12.803325] tailscaled[618]: router: portUpdate(port=41641, network=udp4) hub # [ 12.820664] systemd-logind[538]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) hub # [ 12.823822] tailscaled[618]: pm: migrating "_daemon" profile to new format hub # [ 13.065427] ppdev: user-space parallel port driver hub # [ 12.828145] tailscaled[618]: envknob: PORT="41641" hub # [ 12.829453] systemd-logind[538]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 12.834890] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 12.838817] tailscaled[618]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 12.845473] tailscaled[618]: got LocalBackend in 359ms hub # [ 12.848290] tailscaled[618]: Start hub # [ 12.849374] tailscaled[618]: ipnext: "conn25": skipping extension hub # [ 12.851507] tailscaled[618]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop hub # [ 12.859222] tailscaled[618]: profile data directory: profile not found hub # [ 12.862610] tailscaled[618]: Backend: logs: be:9e31a15b69986d70ea3409418b77416e2da4de2f74523017bc51d1b750aa0d0e fe: hub # [ 12.866378] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 12.868919] tailscaled[618]: blockEngineUpdates(true) worker # [ 9.612264] dhcpcd[665]: eth0: waiting for carrier hub # [ 12.872438] tailscaled[618]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 9.613790] dhcpcd[665]: eth0: carrier acquired hub # [ 12.876487] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 12.879258] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 12.880700] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 12.882818] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 9.624860] dhcpcd[665]: DUID 00:01:00:01:31:e7:6e:f6:52:54:00:12:34:56 hub # [ 12.885225] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 9.626796] dhcpcd[665]: eth0: IAID 00:12:34:56 hub # [ 12.887895] tailscaled[618]: dns: OScfg: {} worker # [ 9.628752] dhcpcd[665]: eth0: adding address fe80::5054:ff:fe12:3456 hub # [ 12.903060] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 9.643348] systemd[1]: Started Tailscale node agent. worker # [ 9.644770] tailscaled[602]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 9.680643] tailscaled[602]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 9.685109] tailscaled[602]: dns: using "openresolv" mode worker # [ 9.692342] tailscaled[602]: dns: using dns.openresolvManager worker # [ 9.696095] tailscaled[602]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 9.701059] tailscaled[602]: magicsock: disco key = d:1d7639e9dd6ae01c worker # [ 9.703264] tailscaled[602]: Creating WireGuard device... worker # [ 9.704786] tailscaled[602]: Bringing WireGuard device up... worker # [ 9.708199] tailscaled[602]: Bringing router up... worker # [ 9.709446] tailscaled[602]: router: using firewall mode pref hub # [ 12.973372] (udev-worker)[761]: Network interface NamePolicy= disabled on kernel command line. worker # [ 9.721101] tailscaled[602]: router: portUpdate(port=41641, network=udp6) worker # [ 9.722749] tailscaled[602]: external route: up hub # [ 12.986539] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 12.991455] systemd[1]: Stopped Virtual Console Setup. hub # [ 13.003467] systemd[1]: Starting Virtual Console Setup... worker # [ 9.743101] tailscaled[602]: router: default choosing iptables worker # [ 9.743328] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 9.764952] tailscaled[602]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 9.770867] tailscaled[602]: router: portUpdate(port=41641, network=udp4) worker # [ 9.773251] tailscaled[602]: Clearing router settings... worker # [ 9.774855] tailscaled[602]: Starting network monitor... worker # [ 9.777277] tailscaled[602]: Engine created. worker # [ 9.787087] tailscaled[602]: pm: migrating "_daemon" profile to new format worker # [ 9.790225] tailscaled[602]: envknob: PORT="41641" worker # [ 9.791468] tailscaled[602]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 9.793292] tailscaled[602]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 13.057810] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.798176] tailscaled[602]: got LocalBackend in 156ms hub # [ 13.060630] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.800247] tailscaled[602]: Start worker # [ 9.802407] tailscaled[602]: ipnext: "conn25": skipping extension worker # [ 9.804372] tailscaled[602]: ipnext: active extensions: posture, clientupdate, relayserver, taildrop, conn25, portlist worker # [ 9.790165] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 9.797032] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 13.070954] systemd[1]: Starting Virtual Console Setup... worker # [ 9.813318] tailscaled[602]: profile data directory: profile not found worker # [ 9.814915] tailscaled[602]: Backend: logs: be:a9b463678bb5b65ca84b58e010480d4bc1926eae5131ef762a34e1ede58a1016 fe: worker # [ 9.817238] tailscaled[602]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 9.819322] tailscaled[602]: blockEngineUpdates(true) worker # [ 9.822355] tailscaled[602]: health(warnable=wantrunning-false): error: Tailscale is stopped. hub # [ 13.083226] systemd-logind[538]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 9.824332] tailscaled[602]: wgengine: Reconfig: configuring router worker # [ 9.825868] tailscaled[602]: wgengine: Reconfig: user dialer worker # [ 9.827273] tailscaled[602]: wgengine: Reconfig: configuring DNS worker # [ 9.829932] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 9.832227] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 9.834080] tailscaled[602]: dns: OScfg: {} worker # [ 9.797144] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 9.797336] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 13.371422] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 13.135560] dhcpcd[680]: eth0: waiting for carrier hub # [ 13.138260] dhcpcd[680]: eth0: carrier acquired hub # [ 13.150463] dhcpcd[680]: DUID 00:01:00:01:31:e7:6e:f7:52:54:00:12:34:56 hub # [ 13.152138] dhcpcd[680]: eth0: IAID 00:12:34:56 hub # [ 13.154176] dhcpcd[680]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 9.905129] systemd[1]: Starting Virtual Console Setup... worker # [ 9.797343] cfg80211: failed to load regulatory.db worker # [ 9.848282] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 9.892283] tun: Universal TUN/TAP device driver, 1.6 worker # [ 9.895241] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 worker # [ 9.917341] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 9.917730] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 9.997436] Console: switching to colour dummy device 80x25 worker # [ 10.222794] ppdev: user-space parallel port driver worker # [ 10.290238] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 10.290241] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 9.945736] systemd-logind[534]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 10.057280] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 10.061331] systemd-logind[534]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 10.065535] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line. worker # [ 10.067820] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 10.071931] systemd[1]: Stopped Virtual Console Setup. worker # [ 10.079134] systemd[1]: Starting Virtual Console Setup... hub # [ 13.356343] dhcpcd[680]: eth0: soliciting a DHCP lease worker # [ 10.335970] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic hub # [ 13.614368] NET: Registered PF_PACKET protocol family worker # [ 10.114505] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) hub # [ 13.380585] dhcpcd[680]: eth0: offered 10.0.2.15 from 10.0.2.2 hub # [ 13.384262] dhcpcd[680]: eth0: probing address 10.0.2.15/24 worker # [ 10.363266] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 10.381025] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 10.407436] Console: switching to colour frame buffer device 160x50 worker # [ 10.418779] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 10.184250] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 10.187434] systemd[1]: Stopped Virtual Console Setup. worker # [ 10.197856] systemd[1]: Starting Virtual Console Setup... hub # [ 13.466791] systemd-vconsole-setup[787]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 13.472376] systemd[1]: Finished Virtual Console Setup. worker # [ 10.245418] systemd-vconsole-setup[737]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 10.253846] systemd[1]: Finished Virtual Console Setup. worker # [ 10.514283] kvm_amd: TSC scaling supported worker # [ 10.515160] kvm_amd: Nested Virtualization enabled worker # [ 10.516400] kvm_amd: Nested Paging enabled worker # [ 10.517361] kvm_amd: LBR virtualization supported worker # [ 10.518477] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 10.519557] kvm_amd: Virtual GIF supported worker # [ 10.520521] kvm_amd: Virtual NMI enabled worker # [ 10.549657] EDAC MC: Ver: 3.0.0 worker # [ 11.027610] dhcpcd[665]: eth0: soliciting a DHCP lease worker # [ 11.281168] NET: Registered PF_PACKET protocol family worker # [ 11.049285] dhcpcd[665]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 11.053475] dhcpcd[665]: eth0: probing address 10.0.2.15/24 worker # [ 12.339575] dhcpcd[665]: eth0: soliciting an IPv6 router worker # [ 12.345929] dhcpcd[665]: eth0: Router Advertisement from fe80::2 worker # [ 12.350824] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 12.357952] dhcpcd[665]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 12.362887] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 12.368767] dhcpcd[665]: eth0: adding route to fec0::/64 worker # [ 12.373658] dhcpcd[665]: eth0: adding default route via fe80::2 worker # [ 12.381791] tailscaled[602]: 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::1d03:d858:fe9d:404e/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::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed] worker # [ 12.403363] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 12.408210] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 12.411854] tailscaled[602]: dns: OScfg: {} worker # [ 12.425415] tailscaled[602]: wgengine: set DNS config again after major link change worker # [ 12.429116] tailscaled[602]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] worker # [ 12.431984] tailscaled[602]: magicsock: 0 active derp conns worker # [ 12.433412] tailscaled[602]: router: portUpdate(port=41641, network=udp6) worker # [ 12.435091] tailscaled[602]: router: portUpdate(port=41641, network=udp4) hub # [ 15.891386] dhcpcd[680]: eth0: soliciting an IPv6 router hub # [ 15.897646] dhcpcd[680]: eth0: Router Advertisement from fe80::2 hub # [ 15.902605] dhcpcd[680]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 15.909708] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 15.914786] dhcpcd[680]: eth0: adding route to fec0::/64 hub # [ 15.919853] dhcpcd[680]: eth0: adding default route via fe80::2 hub # [ 15.924913] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 15.936583] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] rebind-reason=[default-if-changed] hub # [ 15.955486] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 15.958709] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 15.960501] tailscaled[618]: dns: OScfg: {} hub # [ 16.007127] tailscaled[618]: wgengine: set DNS config again after major link change hub # [ 16.009725] tailscaled[618]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] hub # [ 16.012843] tailscaled[618]: magicsock: 0 active derp conns hub # [ 16.014988] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 16.016649] tailscaled[618]: router: portUpdate(port=41641, network=udp4) hub # [ 17.009641] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::e212:692:9bba:3031/128, gw=, outif=2, table=255 worker # [ 13.873452] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 14.388260] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::1d03:d858:fe9d:404e/128, gw=, outif=2, table=255 hub # [ 17.714645] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub # [ 18.487650] dhcpcd[680]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 18.495412] dhcpcd[680]: eth0: adding route to 10.0.2.0/24 hub # [ 18.498722] dhcpcd[680]: eth0: adding default route via 10.0.2.2 hub # [ 18.502869] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 18.505902] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 18.508621] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 18.511484] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 18.619710] systemd[1]: Started DHCP Client. hub # [ 18.623298] systemd[1]: Reached target Network is Online. hub # [ 18.628914] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 18.631247] systemd[1]: Reached target Multi-User System. hub # [ 18.633584] systemd[1]: Startup finished in 973ms (kernel) + 5.421s (initrd) + 12.237s (userspace) = 18.632s. hub: (finished: waiting for unit headscale, in 16.47 seconds) hub: waiting for TCP port 443 on localhost worker # [ 15.612845] dhcpcd[665]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 15.618910] dhcpcd[665]: eth0: adding route to 10.0.2.0/24 hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.07 seconds) hub: waiting for unit tailscaled worker # [ 15.628233] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 15.634579] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 15.642427] dhcpcd[665]: eth0: adding default route via 10.0.2.2 worker # [ 15.646392] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 15.651860] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 18.952183] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] rebind-reason=[ips-changed] worker # [ 15.711698] systemd[1]: Started DHCP Client. worker # [ 15.715381] systemd[1]: Reached target Multi-User System. hub # [ 18.976156] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 15.717302] systemd[1]: Startup finished in 973ms (kernel) + 4.633s (initrd) + 10.110s (userspace) = 15.717s. hub # [ 18.979330] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 18.981090] tailscaled[618]: dns: OScfg: {} hub: (finished: waiting for unit tailscaled, in 0.10 seconds) worker: waiting for unit tailscaled worker: waiting for the VM to finish booting worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 0.00 seconds) worker: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker: (finished: waiting for unit tailscaled, in 0.02 seconds) hub: must succeed: headscale users create test hub # [ 19.015553] headscale-start[897]: 2026-07-13T09:40:13Z WRN hub # [ 19.018486] headscale-start[897]: 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 # [ 19.027774] headscale-start[897]: 2026-07-13T09:40:13Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 19.032771] tailscaled[618]: wgengine: set DNS config again after major link change hub # [ 19.035160] headscale-start[897]: 2026-07-13T09:40:13Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 19.041132] tailscaled[618]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] hub # [ 19.044171] tailscaled[618]: magicsock: 0 active derp conns hub # [ 19.047482] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 19.049275] tailscaled[618]: router: portUpdate(port=41641, network=udp4) hub # [ 19.051468] tailscaled[618]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 19.056857] tailscaled[618]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 19.162408] headscale-start[897]: 2026-07-13T09:40:13Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 19.173099] headscale-start[897]: 2026-07-13T09:40:13Z INF starting headscale commit=v0.29.2 version=0.29.2 hub # [ 19.175522] headscale-start[897]: 2026-07-13T09:40:13Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 19.178810] headscale-start[897]: 2026-07-13T09:40:13Z 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:[0x1c23d8028120]} hub # [ 19.183823] headscale-start[897]: 2026-07-13T09:40:13Z 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 # [ 19.192880] headscale-start[897]: 2026-07-13T09:40:13Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 19.198838] headscale-start[897]: 2026-07-13T09:40:13Z INF stun server started at [::]:3478 hub # [ 19.203404] headscale-start[897]: 2026-07-13T09:40:13Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 19.207489] headscale-start[897]: 2026-07-13T09:40:13Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 19.209711] headscale-start[897]: 2026-07-13T09:40:13Z INF metrics server disabled (metrics_listen_addr is empty) worker # [ 16.401731] tailscaled[602]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::1d03:d858:fe9d:404e/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::1d03:d858:fe9d:404e/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::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed] worker # [ 16.436328] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 16.441371] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 16.446814] tailscaled[602]: dns: OScfg: {} worker # [ 16.465738] tailscaled[602]: wgengine: set DNS config again after major link change worker # [ 16.468748] tailscaled[602]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] worker # [ 16.471845] tailscaled[602]: magicsock: 0 active derp conns worker # [ 16.475321] tailscaled[602]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 16.478381] tailscaled[602]: router: portUpdate(port=41641, network=udp6) worker # [ 16.483579] tailscaled[602]: router: portUpdate(port=41641, network=udp4) worker # [ 16.485224] tailscaled[602]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 20.187816] headscale-start[897]: 2026-07-13T09:40:14Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 1.19 seconds) hub: must succeed: headscale preauthkeys -u 1 create --reusable hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.13 seconds) hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname hub hub # [ 20.390746] tailscaled[618]: localapi: [POST] /localapi/v0/check-prefs hub # [ 20.393785] tailscaled[618]: localapi: [POST] /localapi/v0/start hub # [ 20.395686] tailscaled[618]: Start hub # [ 20.397448] tailscaled[618]: 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 # [ 20.401758] tailscaled[618]: generating new machine key hub # [ 20.407706] tailscaled[618]: machine key written to store hub # [ 20.409380] tailscaled[618]: profile data directory: profile not found hub # [ 20.412824] tailscaled[618]: Backend: logs: be:9e31a15b69986d70ea3409418b77416e2da4de2f74523017bc51d1b750aa0d0e fe: hub # [ 20.420244] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 20.423192] tailscaled[618]: blockEngineUpdates(true) hub # [ 20.424466] tailscaled[618]: Reconfig(down): no changes made to Engine config hub # [ 20.427475] tailscaled[618]: localapi: [POST] /localapi/v0/login-interactive hub # [ 20.429571] tailscaled[618]: StartLoginInteractiveAs("root"): url=false hub # [ 20.431449] tailscaled[618]: control: client.Login(2) hub # [ 20.435328] tailscaled[618]: control: LoginInteractive -> regen=true hub # [ 20.437709] tailscaled[618]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 20.440269] tailscaled[618]: control: client.Shutdown ... hub # [ 20.442212] tailscaled[618]: control: doLogin(regen=true, hasUrl=false) hub # [ 20.444258] tailscaled[618]: health(warnable=wantrunning-false): ok hub # [ 20.446322] tailscaled[618]: control: mapRoutine: exiting hub # [ 20.448932] tailscaled[618]: control: authRoutine: exiting hub # [ 20.450309] tailscaled[618]: control: updateRoutine: exiting hub # [ 20.452338] tailscaled[618]: control: Client.Shutdown done. hub # [ 20.524334] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 20.540890] headscale-start[897]: 2026-07-13T09:40:14Z INF http request bytes=176 elapsed=3.114921 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:34622 status=200 hub # [ 20.548332] tailscaled[618]: control: control server key from https://hub: ts2021=[8N0DL], legacy= hub # [ 20.551408] tailscaled[618]: control: Generating a new nodekey. hub # [ 20.555661] tailscaled[618]: control: RegisterReq: onode= node=[H1abq] fup=false nks=false hub # [ 21.179318] headscale-start[897]: 2026-07-13T09:40:15Z INF http request bytes=249 elapsed=599.275327 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:34632 status=200 hub # [ 21.189823] tailscaled[618]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 21.204196] tailscaled[618]: blockEngineUpdates(false) hub # [ 21.686697] headscale-start[897]: 2026-07-13T09:40:15Z INF http request bytes=0 elapsed=483.431274 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=200 hub # [ 22.184401] headscale-start[897]: 2026-07-13T09:40:16Z INF node connected machine.key=[iJu9q] node.expired=false node.id=1 node.is_tagged=false node.key=[H1abq] node.name=hub node.online=true user.name=test hub # [ 22.197582] headscale-start[897]: 2026-07-13T09:40:16Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x1c23d810ea80 component=poll machine.key=[iJu9q] node.expired=false node.id=1 node.is_tagged=false node.key=[H1abq] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 22.257551] tailscaled[618]: health(warnable=not-in-map-poll): ok hub # [ 22.276336] tailscaled[618]: active login: test hub # [ 22.284782] tailscaled[618]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 22.286774] tailscaled[618]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 22.290448] tailscaled[618]: magicsock: SetPrivateKey called (init) hub # [ 22.292526] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers) hub # [ 22.299176] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 22.535584] tailscaled[618]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [14ms] (forced=false) hub # [ 22.539109] tailscaled[618]: magicsock: home is now derp-999 () hub # [ 22.542236] tailscaled[618]: magicsock: endpoints changed: 127.0.0.1:41641 (stun), [2001:db8:1::1]:41641 (stun), 10.0.2.15:41641 (local), 192.168.1.1:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::e212:692:9bba:3031]:41641 (local) hub # [ 22.547630] tailscaled[618]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 22.550288] tailscaled[618]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 22.552752] tailscaled[618]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 22.558973] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 22.574280] tailscaled[618]: magicsock: derp-999 connected; connGen=1 hub # [ 22.783417] tailscaled[618]: router: enabling connmark-based rp_filter workaround hub # [ 22.879179] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 22.881616] tailscaled[618]: tsdial: bart table size: 2 hub # [ 22.883276] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 22.885201] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1} hub # [ 22.932618] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa} hub # [ 22.935324] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 23.016890] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 23.020808] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 23.022908] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 23.025554] systemd[1]: Stopping User and Group Name Lookups... hub # [ 23.028151] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 23.030085] systemd[1]: nscd.service: Deactivated successfully. hub # [ 23.034493] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 23.043230] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 23.072741] tailscaled[618]: peerapi: serving on http://100.64.0.1:58436 hub # [ 23.076272] tailscaled[618]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 23.081672] tailscaled[618]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 23.089959] tailscaled[618]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 23.098116] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 23.100647] tailscaled[618]: netmap: suggested exit node: () hub # [ 23.107391] tailscaled[618]: writing netmap to disk cache hub # [ 23.109419] nsncd[1043]: Jul 13 09:40:17.224 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 23.113787] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 23.116210] systemd[1]: Reached target User and Group Name Lookups. hub # [ 23.118199] tailscaled[618]: health(warnable=no-derp-connection): ok hub # [ 23.119958] tailscaled[618]: health(warnable=no-derp-connection): ok hub # [ 23.121800] tailscaled[618]: health(warnable=warming-up): ok hub # [ 23.123717] tailscaled[618]: [RATELIMIT] format("health(warnable=%s): ok") hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname hub, in 2.80 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname tt-worker hub # [ 23.187369] headscale-start[897]: 2026-07-13T09:40:17Z INF http request bytes=0 elapsed=90.369027 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=200 worker # [ 19.932872] tailscaled[602]: localapi: [POST] /localapi/v0/check-prefs worker # [ 19.935345] tailscaled[602]: localapi: [POST] /localapi/v0/start worker # [ 19.937129] tailscaled[602]: Start worker # [ 19.938374] tailscaled[602]: 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 # [ 19.942686] tailscaled[602]: generating new machine key worker # [ 19.947203] tailscaled[602]: machine key written to store worker # [ 19.948908] tailscaled[602]: profile data directory: profile not found worker # [ 19.951215] tailscaled[602]: Backend: logs: be:a9b463678bb5b65ca84b58e010480d4bc1926eae5131ef762a34e1ede58a1016 fe: worker # [ 19.954082] tailscaled[602]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 19.957130] tailscaled[602]: blockEngineUpdates(true) worker # [ 19.958426] tailscaled[602]: Reconfig(down): no changes made to Engine config worker # [ 19.961089] tailscaled[602]: control: client.Shutdown ... worker # [ 19.962425] tailscaled[602]: control: mapRoutine: exiting worker # [ 19.964868] tailscaled[602]: control: authRoutine: exiting worker # [ 19.966555] tailscaled[602]: control: updateRoutine: exiting worker # [ 19.968436] tailscaled[602]: control: Client.Shutdown done. worker # [ 19.970090] tailscaled[602]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 19.972686] tailscaled[602]: health(warnable=wantrunning-false): ok worker # [ 19.975082] tailscaled[602]: localapi: [POST] /localapi/v0/login-interactive worker # [ 19.977049] tailscaled[602]: StartLoginInteractiveAs("root"): url=false worker # [ 19.978920] tailscaled[602]: control: client.Login(2) worker # [ 19.982472] tailscaled[602]: control: LoginInteractive -> regen=true worker # [ 19.984719] tailscaled[602]: control: doLogin(regen=true, hasUrl=false) worker # [ 20.011098] tailscaled[602]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 23.278910] headscale-start[897]: 2026-07-13T09:40:17Z INF http request bytes=176 elapsed=0.222654 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:35938 status=200 worker # [ 20.029095] tailscaled[602]: control: control server key from https://hub: ts2021=[8N0DL], legacy= worker # [ 20.031195] tailscaled[602]: control: Generating a new nodekey. worker # [ 20.034282] tailscaled[602]: control: RegisterReq: onode= node=[i9SxN] fup=false nks=false hub # [ 23.690303] headscale-start[897]: 2026-07-13T09:40:17Z INF http request bytes=0 elapsed=494.862336 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=200 hub # [ 23.988567] tailscaled[618]: netmap: suggested exit node: () hub # [ 23.997862] tailscaled[618]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 24.010207] tailscaled[618]: netmap: suggested exit node: () hub # [ 24.195312] headscale-start[897]: 2026-07-13T09:40:18Z INF http request bytes=249 elapsed=877.72608 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:35940 status=200 worker # [ 20.935978] tailscaled[602]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 20.953623] tailscaled[602]: blockEngineUpdates(false) hub # [ 24.692721] headscale-start[897]: 2026-07-13T09:40:18Z INF http request bytes=0 elapsed=469.824796 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35940 status=200 hub # [ 24.797500] tailscaled[618]: netmap: suggested exit node: () hub # [ 24.809691] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) hub # [ 24.816908] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 24.823845] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 24.828798] tailscaled[618]: tsdial: bart table size: 4 hub # [ 24.834890] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 24.838447] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} hub # [ 24.906679] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} hub # [ 24.909428] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 24.962451] tailscaled[618]: netmap: suggested exit node: () hub # [ 24.964580] tailscaled[618]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)") hub # [ 25.058115] tailscaled[618]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 25.195907] headscale-start[897]: 2026-07-13T09:40:19Z INF node connected machine.key=[QfUS0] node.expired=false node.id=2 node.is_tagged=false node.key=[i9SxN] node.name=tt-worker node.online=true user.name=test hub # [ 25.211625] headscale-start[897]: 2026-07-13T09:40:19Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x1c23d80dbb20 component=poll machine.key=[QfUS0] node.expired=false node.id=2 node.is_tagged=false node.key=[i9SxN] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test hub # [ 25.230606] headscale-start[897]: 2026-07-13T09:40:19Z INF http request bytes=0 elapsed=144.511104 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=200 worker # [ 21.994791] tailscaled[602]: health(warnable=not-in-map-poll): ok worker # [ 22.023130] tailscaled[602]: active login: test worker # [ 22.036453] tailscaled[602]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 22.043767] tailscaled[602]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 22.058572] tailscaled[602]: magicsock: SetPrivateKey called (init) worker # [ 22.061570] tailscaled[602]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) worker # [ 22.066586] tailscaled[602]: wgengine: Reconfig: configuring router worker # [ 22.208634] tailscaled[602]: router: enabling connmark-based rp_filter workaround worker # [ 22.232745] tailscaled[602]: wgengine: Reconfig: user dialer worker # [ 22.234705] tailscaled[602]: tsdial: bart table size: 4 worker # [ 22.235990] tailscaled[602]: wgengine: Reconfig: configuring DNS worker # [ 22.237475] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} worker # [ 22.256170] tailscaled[602]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} worker # [ 22.258713] tailscaled[602]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 22.299820] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 22.304390] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 22.306536] tailscaled[602]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [16ms] (forced=false) worker # [ 22.308810] tailscaled[602]: magicsock: home is now derp-999 () worker # [ 22.311238] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 22.313208] tailscaled[602]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::1d03:d858:fe9d:404e]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local) worker # [ 22.318588] systemd[1]: Stopping User and Group Name Lookups... worker # [ 22.320196] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 22.323456] systemd[1]: nscd.service: Deactivated successfully. worker # [ 22.326186] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 22.330873] tailscaled[602]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 22.332874] tailscaled[602]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 22.335170] tailscaled[602]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 22.348624] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 22.351200] tailscaled[602]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 22.364116] tailscaled[602]: magicsock: derp-999 connected; connGen=1 worker # [ 22.371405] tailscaled[602]: peerapi: serving on http://100.64.0.2:46590 worker # [ 22.374439] tailscaled[602]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 22.379605] tailscaled[602]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 22.382956] tailscaled[602]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 22.390099] tailscaled[602]: writing netmap to disk cache worker # [ 22.393282] tailscaled[602]: health(warnable=no-derp-connection): ok worker # [ 22.395807] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 22.398305] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 22.400754] nsncd[921]: Jul 13 09:40:19.714 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 22.405840] tailscaled[602]: health(warnable=no-derp-connection): ok worker # [ 22.407770] systemd[1]: Reached target User and Group Name Lookups. worker # [ 22.410698] tailscaled[602]: health(warnable=no-derp-connection): ok worker # [ 22.412600] tailscaled[602]: [RATELIMIT] format("health(warnable=%s): ok") worker # [ 22.415604] tailscaled[602]: netmap: suggested exit node: () worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname tt-worker, in 2.55 seconds) worker: waiting for success: tailscale ping hub hub # [ 25.697308] headscale-start[897]: 2026-07-13T09:40:19Z INF http request bytes=0 elapsed=51.560463 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35940 status=200 worker # [ 22.449639] tailscaled[602]: localapi: [POST] /localapi/v0/ping worker # [ 22.451674] tailscaled[602]: ping(100.64.0.1): sending disco ping to [H1abq] hub ... worker # [ 22.460862] tailscaled[602]: magicsock: disco: node [H1abq] d:2a3dc5d3af0b735e now using 192.168.1.1:41641 mtu=1360 tx=20d5ec671887 worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds) hub: must succeed: tailscale ip -4 hub: (finished: must succeed: tailscale ip -4, in 0.06 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.02 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 25.843429] systemd[1]: Starting tribuchet-hub.socket... hub # [ 25.853907] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 25.859555] systemd[1]: Starting tribuchet-hub.service... hub # [ 25.931557] tribuchet[1086]: 2026-07-13T09:40:20.047573Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 25.937616] tribuchet[1086]: 2026-07-13T09:40:20.055849Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers hub # [ 25.942655] tribuchet[1086]: 2026-07-13T09:40:20.060719Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 25.950701] tribuchet[1086]: 2026-07-13T09:40:20.068751Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 25.955963] 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 # [ 22.758355] systemd[1]: Starting tribuchet-worker.service... worker # [ 22.852140] exec[962]: 2026-07-13T09:40:20.167908Z 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 # [ 22.864626] exec[962]: 2026-07-13T09:40:20.181127Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service worker # [ 22.872090] exec[965]: 2026-07-13T09:40:20.187629Z 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 # [ 22.886648] exec[965]: 2026-07-13T09:40:20.203261Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 22.894049] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.20 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' hub # [ 26.187131] tailscaled[618]: magicsock: disco: node [i9SxN] d:1d7639e9dd6ae01c now using 192.168.1.2:41641 mtu=1360 tx=5c72ee3c10b1 hub # [ 26.210534] headscale-start[897]: 2026-07-13T09:40:20Z INF http request bytes=0 elapsed=498.42005 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35940 status=200 hub # [ 26.248975] tribuchet[1086]: 2026-07-13T09:40:20.367131Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }] hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 0.11 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 worker # [ 23.020712] exec[965]: 2026-07-13T09:40:20.336992Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] worker # [ 23.127930] tailscaled[602]: netmap: suggested exit node: () worker # [ 23.137233] tailscaled[602]: [RATELIMIT] format("control: [v\x00JSON]%d%s") worker # [ 23.144245] tailscaled[602]: netmap: suggested exit node: () hub: (finished: must succeed: nix-store --add /root/payload, in 0.14 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.725659] tribuchet[1086]: 2026-07-13T09:40:20.844040Z INFO tribuchet::hub::submit: queueing build id="7bc54b05ab43aba55f0a6c1d36b59574" system="x86_64-linux" hub # [ 26.730808] tribuchet[1086]: 2026-07-13T09:40:20.849174Z INFO tribuchet::hub: dispatching build id="7bc54b05ab43aba55f0a6c1d36b59574" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 23.477940] exec[965]: 2026-07-13T09:40:20.794259Z INFO tribuchet::worker: build assigned id="7bc54b05ab43aba55f0a6c1d36b59574" worker # [ 23.495964] systemd[1]: Started Nix Daemon. worker # [ 23.557717] nix-daemon[967]: accepted connection from pid 965, user tribuchet (trusted) worker # [ 23.564571] exec[965]: 2026-07-13T09:40:20.881177Z 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 # [ 23.570443] exec[965]: 2026-07-13T09:40:20.886872Z INFO harmonia_store_remote::client: Nix Version "2.34.8" version="2.34.8" hub # [ 26.838383] tribuchet[1086]: 2026-07-13T09:40:20.956235Z INFO tribuchet::hub::relay: input path negotiation done id="7bc54b05ab43aba55f0a6c1d36b59574" total=8 missing=1 hub # [ 26.858510] systemd[1]: Started Nix Daemon. hub # [ 26.974158] nix-daemon[1115]: accepted connection from pid 1086, user root (trusted) hub # [ 26.984233] tribuchet[1086]: 2026-07-13T09:40:21.102018Z 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.989990] tribuchet[1086]: 2026-07-13T09:40:21.108358Z INFO harmonia_store_remote::client: Nix Version "2.34.8+2" version="2.34.8+2" worker # [ 23.802608] systemd[1]: Starting tribuchet-sandboxd.service... worker # [ 23.847375] tribuchet-sandboxd[973]: 2026-07-13T09:40:21.163764Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock worker # [ 23.852298] systemd[1]: Started tribuchet-sandboxd.service. worker # [ 23.855106] tribuchet-sandboxd[973]: 2026-07-13T09:40:21.171071Z INFO tribuchet_sandboxd: leased build="7bc54b05ab43aba55f0a6c1d36b59574" base=1325400064 uid_count=1 worker # [ 23.859799] exec[965]: 2026-07-13T09:40:21.171184Z INFO tribuchet::worker::build: leased sandbox build_id="7bc54b05ab43aba55f0a6c1d36b59574" pool_base=1325400064 uid_count=1 worker # [ 23.864791] exec[965]: 2026-07-13T09:40:21.181408Z INFO tribuchet::worker::build: sandbox network decision id="7bc54b05ab43aba55f0a6c1d36b59574" fixed_output=false network=false net_isolation=false worker # [ 24.278578] exec[965]: 2026-07-13T09:40:21.593014Z INFO tribuchet::worker::build: builder finished id="7bc54b05ab43aba55f0a6c1d36b59574" exit_code=0 worker # [ 24.299279] exec[965]: 2026-07-13T09:40:21.614887Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="7bc54b05ab43aba55f0a6c1d36b59574" worker # [ 24.329291] exec[965]: 2026-07-13T09:40:21.645674Z INFO tribuchet::worker::resume: build result acknowledged id="7bc54b05ab43aba55f0a6c1d36b59574" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 1.17 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.45 seconds) subtest: a non-tailnet peer is rejected worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml worker # [ 24.457366] tribuchet-sandboxd[973]: 2026-07-13T09:40:21.773624Z INFO tribuchet_sandboxd: released build="7bc54b05ab43aba55f0a6c1d36b59574" base=1325400064 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 # [ 24.496101] exec[965]: 2026-07-13T09:40:21.811159Z INFO tribuchet::worker: handover requested; exiting worker # [ 24.500443] systemd[1]: Stopping tribuchet-worker.service... hub # [ 27.764424] tribuchet[1086]: 2026-07-13T09:40:21.882227Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 24.698762] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 24.707354] systemd[1]: Stopped tribuchet-worker.service. worker # [ 24.711862] systemd[1]: tribuchet-worker.service: Consumed 86ms CPU time over 1.946s wall clock time, 18.7M memory peak, 14.3M read from disk, 4K written to disk, 3.9K incoming IP traffic, 2.1K outgoing IP traffic. worker # [ 24.738106] systemd[1]: Starting tribuchet-worker.service... worker # [ 24.789381] exec[999]: 2026-07-13T09:40:22.105288Z 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 # [ 24.802609] exec[999]: 2026-07-13T09:40:22.119118Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service worker # [ 24.809400] exec[1002]: 2026-07-13T09:40:22.125597Z 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 # [ 24.820509] exec[1002]: 2026-07-13T09:40:22.137113Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 24.827985] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.35 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' hub # [ 28.464876] tribuchet[1086]: 2026-07-13T09:40:22.581983Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:43986 worker # [ 25.216264] exec[1002]: 2026-07-13T09:40:22.532558Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 25.227725] exec[1002]: 2026-07-13T09:40:22.532649Z INFO tribuchet::worker: reconnecting to hub in 1s worker # [ 25.460694] tailscaled[602]: magicsock: disco: node [H1abq] d:2a3dc5d3af0b735e now using [2001:db8:1::1]:41641 mtu=1360 tx=11691e690cac hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.12 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.49 seconds) (finished: run the VM test script, in 30.32 seconds) test script finished in 30.41s cleanup kill QemuMachine (pid 47) 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 48) 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.33 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