tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script start all VMs hub: starting vm worker: starting vm hub # Disk image does not exist, creating the virtualisation disk image... hub: QEMU running (pid 47) hub # Formatting '/build/vm-state-hub/tmp.0EXQe23Ffm', 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: a21bc524-698c-408d-a6b2-0af2a3857541 hub # Superblock backups stored on blocks: hub # 32768, 98304, 163840, 229376 hub # hub # Allocating group tables: 0/8 done hub # Writing inode tables: 0/8 done hub # Creating journal (8192 blocks): done hub # Writing superblocks and filesystem accounting information: 0/8 done hub # hub # Virtualisation disk image created. hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1920+7EF31920 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:03.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1920 7EF31920 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:09.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 0.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 UTC 2026 hub # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/qiz4v4yb8dxdmad79hv2a9n0001vb0n1-nixos-system-hub-test/init regInfo=/nix/store/vbhxa1gs5b9nchlqhbb7rn6a0fwza80z-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 511071146 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000005] tsc: Detected 2400.018 MHz processor hub # [ 0.000812] last_pfn = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000848] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000851] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002753] found SMP MP-table at [mem 0x000f5470-0x000f547f] hub # [ 0.002765] Using GB pages for direct mapping hub # [ 0.002890] RAMDISK: [mem 0x7e302000-0x7ffcffff] hub # [ 0.002898] ACPI: Early table checksum verification disabled hub # [ 0.002901] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) hub # [ 0.002905] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002909] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002916] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002918] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002920] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002921] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002923] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002924] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] hub # [ 0.002925] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] hub # [ 0.002926] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002926] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] hub # [ 0.002927] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] hub # [ 0.002927] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] hub # [ 0.003421] No NUMA configuration found hub # [ 0.003422] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] hub # [ 0.003425] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] hub # [ 0.005912] Zone ranges: hub # [ 0.005913] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005915] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] hub # [ 0.005917] Normal empty hub # [ 0.005918] Device empty hub # [ 0.005918] Movable zone start for each node hub # [ 0.005919] Early memory node ranges hub # [ 0.005919] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005921] node 0: [mem 0x0000000000100000-0x000000007ffdafff] hub # [ 0.005922] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] hub # [ 0.005945] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006275] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.046072] On node 0, zone DMA32: 37 pages in unavailable ranges hub # [ 0.047094] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.047111] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.047150] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.047153] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.047154] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.047156] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.047157] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.047157] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.047160] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.047161] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.047166] TSC deadline timer available hub # [ 0.047171] CPU topo: Max. logical packages: 1 hub # [ 0.047171] CPU topo: Max. logical dies: 1 hub # [ 0.047172] CPU topo: Max. dies per package: 1 hub # [ 0.047175] CPU topo: Max. threads per core: 1 hub # [ 0.047176] CPU topo: Num. cores per package: 1 hub # [ 0.047176] CPU topo: Num. threads per package: 1 hub # [ 0.047176] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.047198] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.047238] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.047239] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.047241] [mem 0x80000000-0xfeffbfff] available for PCI devices hub # [ 0.047242] Booting paravirtualized kernel on KVM hub # [ 0.047245] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.051702] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.054238] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.054287] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.054289] 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/qiz4v4yb8dxdmad79hv2a9n0001vb0n1-nixos-system-hub-test/init regInfo=/nix/store/vbhxa1gs5b9nchlqhbb7rn6a0fwza80z-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.054391] Unknown kernel command line parameters "regInfo=/nix/store/vbhxa1gs5b9nchlqhbb7rn6a0fwza80z-closure-info/registration", will be passed to user space. hub # [ 0.054404] random: crng init done hub # [ 0.054405] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.056653] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.056675] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.056708] Fallback order for Node 0: 0 hub # [ 0.056711] Built 1 zonelists, mobility grouping on. Total pages: 524153 hub # [ 0.056711] Policy zone: DMA32 hub # [ 0.059276] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.063082] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.068344] allocated 4194304 bytes of page_ext hub # [ 0.078061] ftrace: allocating 48598 entries in 192 pages hub # [ 0.078063] ftrace: allocated 192 pages with 2 groups hub # [ 0.078915] Dynamic Preempt: lazy hub # [ 0.079051] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.079052] rcu: RCU event tracing is enabled. hub # [ 0.079053] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.079055] Trampoline variant of Tasks RCU enabled. hub # [ 0.079055] Rude variant of Tasks RCU enabled. hub # [ 0.079055] Tracing variant of Tasks RCU enabled. hub # [ 0.079056] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.079057] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.079066] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.079067] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.079069] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.083458] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.083747] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.083856] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.091092] Console: colour VGA+ 80x25 hub # [ 0.091096] printk: legacy console [tty0] enabled hub # [ 0.131794] printk: legacy console [ttyS0] enabled hub # [ 0.321782] ACPI: Core revision 20250807 hub # [ 0.323463] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.326487] APIC: Switch to symmetric I/O mode setup hub # [ 0.328264] x2apic enabled hub # [ 0.329519] APIC: Switched APIC routing to: physical x2apic hub # [ 0.332429] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.334347] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.337566] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) hub # [ 0.338684] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.340730] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.342564] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.343569] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.345564] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.347564] Transient Scheduler Attacks: Mitigation: Clear CPU buffers hub # [ 0.348564] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.349564] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.351564] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.353570] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.354564] active return thunk: srso_alias_return_thunk hub # [ 0.356593] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.357564] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.358564] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.360564] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.361564] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.362564] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.364564] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.366564] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 0.367564] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' hub # [ 0.368564] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.370564] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.372564] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.373564] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.374564] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.375564] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 hub # [ 0.377564] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 hub # [ 0.379564] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 0.414061] Freeing SMP alternatives memory: 44K hub # [ 0.414566] pid_max: default: 32768 minimum: 301 hub # [ 0.416666] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.417670] landlock: Up and running. hub # [ 0.418564] Yama: becoming mindful. hub # [ 0.419776] LSM support for eBPF active hub # [ 0.421675] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.422607] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.425219] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.426166] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.426569] ... version: 2 hub # [ 0.427565] ... bit width: 48 hub # [ 0.428579] ... generic counters: 6 hub # [ 0.429565] ... generic bitmap: 000000000000003f hub # [ 0.430566] ... fixed-purpose counters: 0 hub # [ 0.431565] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.432565] ... value mask: 0000ffffffffffff hub # [ 0.433565] ... max period: 00007fffffffffff hub # [ 0.434566] ... global_ctrl mask: 000000000000003f hub # [ 0.435687] signal: max sigframe size: 3376 hub # [ 0.436675] rcu: Hierarchical SRCU implementation. hub # [ 0.437572] rcu: Max phase no-delay instances is 400. hub # [ 0.443437] smp: Bringing up secondary CPUs ... hub # [ 0.444580] smp: Brought up 1 node, 1 CPU hub # [ 0.445569] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) hub # [ 0.446784] Memory: 1969248K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved) hub # [ 0.447905] devtmpfs: initialized hub # [ 0.448773] x86/mm: Memory block size: 128MB hub # [ 0.450797] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.451612] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.452599] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.453683] pinctrl core: initialized pinctrl subsystem hub # [ 0.454943] PM: RTC time: 12:18:53, date: 2026-07-15 hub # [ 0.459030] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.460133] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.460603] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.461890] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.462580] audit: initializing netlink subsys (disabled) hub # [ 0.463915] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.463918] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.464568] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.465571] audit: type=2000 audit(1784117933.611:1): state=initialized audit_enabled=0 res=1 hub # [ 0.467570] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.467572] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.468587] cpuidle: using governor menu hub # [ 0.471804] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.472906] PCI: Using configuration type 1 for base access hub # [ 0.473566] PCI: Using configuration type 1 for extended access hub # [ 0.474789] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.481878] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.482566] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.487566] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.488566] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.497733] ACPI: Added _OSI(Module Device) hub # [ 0.498567] ACPI: Added _OSI(Processor Device) hub # [ 0.501571] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.506459] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.512997] ACPI: Interpreter enabled hub # [ 0.513583] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.514567] ACPI: Using IOAPIC for interrupt routing hub # [ 0.515585] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.518570] PCI: Using E820 reservations for host bridge windows hub # [ 0.519718] ACPI: Enabled 2 GPEs in block 00 to 0F hub # [ 0.528508] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.529572] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.531085] acpiphp: Slot [3] registered hub # [ 0.531643] acpiphp: Slot [4] registered hub # [ 0.532696] acpiphp: Slot [5] registered hub # [ 0.533633] acpiphp: Slot [6] registered hub # [ 0.534624] acpiphp: Slot [7] registered hub # [ 0.535644] acpiphp: Slot [8] registered hub # [ 0.536649] acpiphp: Slot [9] registered hub # [ 0.537627] acpiphp: Slot [10] registered hub # [ 0.538630] acpiphp: Slot [11] registered hub # [ 0.539648] acpiphp: Slot [12] registered hub # [ 0.540631] acpiphp: Slot [13] registered hub # [ 0.541599] acpiphp: Slot [14] registered hub # [ 0.542608] acpiphp: Slot [15] registered hub # [ 0.543613] acpiphp: Slot [16] registered hub # [ 0.544599] acpiphp: Slot [17] registered hub # [ 0.545599] acpiphp: Slot [18] registered hub # [ 0.546598] acpiphp: Slot [19] registered hub # [ 0.547614] acpiphp: Slot [20] registered hub # [ 0.548599] acpiphp: Slot [21] registered hub # [ 0.549598] acpiphp: Slot [22] registered hub # [ 0.550598] acpiphp: Slot [23] registered hub # [ 0.551620] acpiphp: Slot [24] registered hub # [ 0.552600] acpiphp: Slot [25] registered hub # [ 0.553600] acpiphp: Slot [26] registered hub # [ 0.554623] acpiphp: Slot [27] registered hub # [ 0.555598] acpiphp: Slot [28] registered hub # [ 0.556620] acpiphp: Slot [29] registered hub # [ 0.557599] acpiphp: Slot [30] registered hub # [ 0.558612] acpiphp: Slot [31] registered hub # [ 0.559590] PCI host bridge to bus 0000:00 hub # [ 0.560572] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.561567] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.562566] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.563567] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] hub # [ 0.564567] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] hub # [ 0.565567] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.567014] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.568475] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.570500] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint hub # [ 0.573644] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] hub # [ 0.574653] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk hub # [ 0.575566] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk hub # [ 0.576566] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk hub # [ 0.577566] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk hub # [ 0.578995] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.580631] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] hub # [ 0.582912] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint hub # [ 0.584324] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI hub # [ 0.585580] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB hub # [ 0.586987] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.589646] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.590596] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.591619] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.592802] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.594763] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.597600] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.598581] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.599626] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.600581] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.603752] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.606591] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.607581] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.608625] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.611642] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.614581] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.615581] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.616644] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.619567] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.622550] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.623582] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.624620] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.627776] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.630601] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.631580] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.632618] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.635865] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.638599] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.639580] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.640619] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.643792] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.646591] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.647580] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.648620] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.649580] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.652566] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.655037] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.655619] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.658605] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.661780] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.662581] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.663619] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.666645] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.669566] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.670580] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.671619] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.680072] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.680779] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.681759] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.682753] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.683681] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 hub # [ 0.685785] iommu: Default domain type: Translated hub # [ 0.686575] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.687860] ACPI: bus type USB registered hub # [ 0.688627] usbcore: registered new interface driver usbfs hub # [ 0.689599] usbcore: registered new interface driver hub hub # [ 0.690576] usbcore: registered new device driver usb hub # [ 0.692514] NetLabel: Initializing hub # [ 0.693398] NetLabel: domain hash size = 128 hub # [ 0.694565] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.695626] NetLabel: unlabeled traffic allowed by default hub # [ 0.696580] PCI: Using ACPI for IRQ routing hub # [ 0.698214] pci 0000:00:02.0: vgaarb: setting as boot VGA device hub # [ 0.698561] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 0.698561] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.698567] vgaarb: loaded hub # [ 0.699714] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.700566] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.707649] clocksource: Switched to clocksource kvm-clock hub # [ 0.711790] VFS: Disk quotas dquot_6.6.0 hub # [ 0.713353] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.715643] pnp: PnP ACPI init hub # [ 0.717357] pnp: PnP ACPI: found 6 devices hub # [ 0.725603] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.728223] clocksource: Switched to clocksource acpi_pm hub # [ 0.729973] NET: Registered PF_INET protocol family hub # [ 0.731911] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.750454] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.753158] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.755501] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.757922] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.760139] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.762157] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.764423] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.766421] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.768585] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.770401] NET: Registered PF_XDP protocol family hub # [ 0.771912] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.773763] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.775656] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.777717] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] hub # [ 0.779774] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] hub # [ 0.781970] pci 0000:00:01.0: PIIX3: Enabling Passive Release hub # [ 0.783721] pci 0000:00:00.0: Limiting direct PCI/PCI transfers hub # [ 0.787136] ACPI: \_SB_.LNKD: Enabled at IRQ 11 hub # [ 0.790595] PCI: CLS 0 bytes, default 64 hub # [ 0.792145] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.795171] Trying to unpack rootfs image as initramfs... hub # [ 0.841126] Initialise system trusted keyrings hub # [ 0.845951] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.871085] Key type asymmetric registered hub # [ 0.872441] Asymmetric key parser 'x509' registered hub # [ 0.877934] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.882922] io scheduler mq-deadline registered hub # [ 0.884368] io scheduler kyber registered hub # [ 0.889882] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.894238] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.903053] Linux agpgart interface v0.103 hub # [ 0.904426] ACPI: bus type drm_connector registered hub # [ 0.910351] usbcore: registered new interface driver usbserial_generic hub # [ 0.912316] usbserial: USB Serial support registered for generic hub # [ 0.917865] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.917865] Please enable it if your BIOS has the CPPC option. hub # [ 0.928880] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.931244] drop_monitor: Initializing network drop monitor service hub # [ 0.938000] NET: Registered PF_INET6 protocol family hub # [ 0.940094] Segment Routing with IPv6 hub # [ 0.942876] In-situ OAM (IOAM) with IPv6 hub # [ 0.947160] IPI shorthand broadcast: enabled hub # [ 0.955973] sched_clock: Marking stable (708029464, 247807917)->(1158110373, -202272992) hub # [ 0.964120] registered taskstats version 1 hub # [ 0.965693] Loading compiled-in X.509 certificates hub # [ 0.987891] Demotion targets for Node 0: null hub # [ 0.990896] Key type .fscrypt registered hub # [ 0.993858] Key type fscrypt-provisioning registered hub # [ 0.995539] ima: No TPM chip found, activating TPM-bypass! hub # [ 1.000866] ima: Allocated hash algorithm: sha1 hub # [ 1.002354] ima: No architecture policies found hub # [ 1.007055] PM: Magic number: 2:676:329 hub # [ 1.008371] tty tty50: hash matches hub # [ 1.013738] RAS: Correctable Errors collector initialized. hub # [ 1.023645] clk: Disabling unused clocks hub # [ 1.026872] PM: genpd: Disabling unused power domains hub # [ 1.170799] Freeing initrd memory: 29496K hub # [ 1.174699] Freeing unused decrypted memory: 2028K hub # [ 1.178228] Freeing unused kernel image (initmem) memory: 3636K hub # [ 1.180113] Write protecting the kernel read-only data: 32768k hub # [ 1.182913] Freeing unused kernel image (text/rodata gap) memory: 1272K hub # [ 1.185366] Freeing unused kernel image (rodata/data gap) memory: 796K hub # [ 1.238423] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.240383] Run /init as init process hub # [ 1.251926] systemd[1]: Inserted module 'autofs4' hub # [ 1.269057] fuse: init (API version 7.45) hub # [ 1.276953] ACPI: \_SB_.LNKC: Enabled at IRQ 10 hub # [ 1.289226] ACPI: \_SB_.LNKA: Enabled at IRQ 10 hub # [ 1.295324] ACPI: \_SB_.LNKB: Enabled at IRQ 11 hub # [ 1.342909] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.682401] 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.704117] systemd[1]: Detected virtualization kvm. hub # [ 1.708109] systemd[1]: Detected architecture x86-64. hub # [ 1.712145] systemd[1]: Running in initrd. hub # [ 1.716471] systemd[1]: Initializing machine ID from random generator. hub # [ 1.721682] systemd[1]: Hostname set to . hub # [ 1.940555] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 2.001150] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 2.006528] systemd[1]: Created slice Slice /system/modprobe. hub # [ 2.008651] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 2.011160] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 2.013147] systemd[1]: Reached target Path Units. hub # [ 2.014835] systemd[1]: Reached target Slice Units. hub # [ 2.016460] systemd[1]: Reached target Swaps. hub # [ 2.017917] systemd[1]: Reached target Timer Units. hub # [ 2.019656] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 2.021901] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 2.024007] systemd[1]: Listening on Journal Sockets. hub # [ 2.025780] systemd[1]: Listening on udev Control Socket. hub # [ 2.027660] systemd[1]: Listening on udev Kernel Socket. hub # [ 2.029446] systemd[1]: Reached target Socket Units. hub # [ 2.032155] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 2.038123] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.050525] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.063051] systemd[1]: Starting Journal Service... hub # [ 2.079939] systemd[1]: Starting Load Kernel Modules... hub # [ 2.089342] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.106221] netfs: FS-Cache loaded hub # [ 2.121266] 9pnet: Installing 9P2000 support hub # [ 2.141711] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.146330] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.152070] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.154995] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.168932] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.179586] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.190499] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.197432] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.206502] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.215992] systemd[1]: Finished Load Kernel Modules. hub # [ 2.221657] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.237114] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.254974] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.282993] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.299072] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.309241] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.329846] systemd[1]: Started Journal Service. hub # [ 2.086336] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.090204] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.094181] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.108285] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.114228] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.117182] systemd[1]: Reached target Local File Systems. hub # [ 2.120101] systemd[1]: Starting Create System Files and Directories... hub # [ 2.125786] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.156916] systemd[1]: Finished Create System Files and Directories. hub # [ 2.184393] systemd-udevd[83]: Using default interface naming scheme 'v261'. hub # [ 2.219173] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.253159] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.254734] systemd[1]: Reached target System Initialization. hub # [ 2.256266] systemd[1]: Reached target Basic System. worker # Disk image does not exist, creating the virtualisation disk image... worker: QEMU running (pid 48) worker # Formatting '/build/vm-state-worker/tmp.bCXwrvRegy', fmt=raw size=1073741824 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/262144 done worker # Creating filesystem with 262144 4k blocks and 65536 inodes worker # Filesystem UUID: 931ebe91-e5db-4765-a886-fc7eb2f6567c worker # Superblock backups stored on blocks: (finished: start all VMs, in 3.45 seconds) worker # 32768, 98304, 163840, 229376 hub: waiting for unit headscale worker # hub: waiting for the VM to finish booting 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 worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)... worker # worker # worker # Booting from ROM... worker # Probing EDD (edd=off to disable)... ok hub # [ 2.819777] uhci_hcd 0000:00:01.2: UHCI Host Controller hub # [ 2.831662] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 2.838382] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 hub # [ 2.851974] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.854453] uhci_hcd 0000:00:01.2: detected 2 ports hub # [ 2.857458] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 2.862609] SCSI subsystem initialized hub # [ 2.865367] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 hub # [ 2.870538] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.881174] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.883108] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.892878] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.914639] usb usb1: Product: UHCI Host Controller hub # [ 2.926697] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd hub # [ 2.946531] usb usb1: SerialNumber: 0000:00:01.2 hub # [ 2.950185] hub 1-0:1.0: USB hub found hub # [ 2.709333] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.965300] hub 1-0:1.0: 2 ports detected hub # [ 2.719277] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.723286] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.728461] systemd[1]: Starting Virtual Console Setup... hub # [ 2.767778] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.773551] systemd[1]: Finished Virtual Console Setup. hub # [ 3.042577] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.819311] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.822088] systemd[1]: Reached target Initrd Root Device. hub # [ 3.071534] scsi host0: ata_piix hub # [ 2.825729] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 3.078141] scsi host1: ata_piix hub # [ 3.081500] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 hub # [ 3.084301] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 hub # [ 2.856559] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.863651] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 0.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 UTC 2026 worker # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/gcjgvnd3nai9585v6jgrnbs5p1103pqh-nixos-system-worker-test/init regInfo=/nix/store/3garh1b0zl95vbrcsi117yp210my9wfz-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved worker # [ 0.000000] NX (Execute Disable) protection: active worker # [ 0.000000] APIC: Static calls initialized hub # [ 2.915326] systemd[1]: Mounting /sysroot... 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 481710897 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.000817] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000853] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000856] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.002760] found SMP MP-table at [mem 0x000f5470-0x000f547f] worker # [ 0.002771] Using GB pages for direct mapping worker # [ 0.002829] RAMDISK: [mem 0x7e2fa000-0x7ffcffff] worker # [ 0.002837] ACPI: Early table checksum verification disabled worker # [ 0.002840] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) worker # [ 0.002843] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002847] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002854] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002856] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002858] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002859] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002861] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002862] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] worker # [ 0.002863] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] worker # [ 0.002864] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002864] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] worker # [ 0.002865] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] worker # [ 0.002865] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] worker # [ 0.003353] No NUMA configuration found worker # [ 0.003354] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] hub # [ 3.211869] usb 1-1: new full-speed USB device number 2 using uhci_hcd worker # [ 0.003358] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] worker # [ 0.005754] Zone ranges: worker # [ 0.005755] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.005757] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] worker # [ 0.005758] Normal empty worker # [ 0.005759] Device empty worker # [ 0.005759] Movable zone start for each node worker # [ 0.005760] Early memory node ranges worker # [ 0.005761] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005762] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] worker # [ 0.005763] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] worker # [ 0.005785] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.006061] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.044000] On node 0, zone DMA32: 40 pages in unavailable ranges worker # [ 0.045000] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.045015] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.045047] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.045050] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.045051] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.045052] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.045053] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.045054] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.045056] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 3.244105] ata2: found unknown device (class 0) worker # [ 0.045057] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.045062] TSC deadline timer available worker # [ 0.045066] CPU topo: Max. logical packages: 1 hub # [ 3.246460] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 0.045067] CPU topo: Max. logical dies: 1 worker # [ 0.045067] CPU topo: Max. dies per package: 1 worker # [ 0.045071] CPU topo: Max. threads per core: 1 worker # [ 0.045071] CPU topo: Num. cores per package: 1 hub # [ 3.250499] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 0.045071] CPU topo: Num. threads per package: 1 worker # [ 0.045072] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.045100] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.045137] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.045139] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.045140] [mem 0x80000000-0xfeffbfff] available for PCI devices worker # [ 0.045142] Booting paravirtualized kernel on KVM worker # [ 0.045145] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.049591] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.051900] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.051946] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.051947] 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/gcjgvnd3nai9585v6jgrnbs5p1103pqh-nixos-system-worker-test/init regInfo=/nix/store/3garh1b0zl95vbrcsi117yp210my9wfz-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.052039] Unknown kernel command line parameters "regInfo=/nix/store/3garh1b0zl95vbrcsi117yp210my9wfz-closure-info/registration", will be passed to user space. worker # [ 0.052052] random: crng init done worker # [ 0.052053] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.054664] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.054686] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.054718] Fallback order for Node 0: 0 worker # [ 0.054721] Built 1 zonelists, mobility grouping on. Total pages: 524150 worker # [ 0.054722] Policy zone: DMA32 worker # [ 0.057323] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.061307] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.066005] allocated 4194304 bytes of page_ext worker # [ 0.075776] ftrace: allocating 48598 entries in 192 pages worker # [ 0.075778] ftrace: allocated 192 pages with 2 groups worker # [ 0.077019] Dynamic Preempt: lazy worker # [ 0.077163] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.077164] rcu: RCU event tracing is enabled. hub # [ 3.298594] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 0.077165] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.077166] Trampoline variant of Tasks RCU enabled. worker # [ 0.077166] Rude variant of Tasks RCU enabled. worker # [ 0.077166] Tracing variant of Tasks RCU enabled. worker # [ 0.077167] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.077168] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.077185] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.077187] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.077188] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.081610] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.081893] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 3.317264] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 0.081999] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.089253] Console: colour VGA+ 80x25 worker # [ 0.089256] printk: legacy console [tty0] enabled worker # [ 0.130174] printk: legacy console [ttyS0] enabled worker # [ 0.317553] ACPI: Core revision 20250807 worker # [ 0.319089] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.321936] APIC: Switch to symmetric I/O mode setup worker # [ 0.323672] x2apic enabled worker # [ 0.324915] APIC: Switched APIC routing to: physical x2apic worker # [ 0.327743] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.329565] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 3.338503] EXT4-fs (vda): mounted filesystem a21bc524-698c-408d-a6b2-0af2a3857541 r/w with ordered data mode. Quota mode: none. worker # [ 0.332642] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) worker # [ 0.334757] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.335801] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.336641] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 3.100738] systemd[1]: Mounted /sysroot. worker # [ 0.337645] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.338641] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 3.103745] systemd[1]: Reached target Initrd Root File System. worker # [ 0.339641] Transient Scheduler Attacks: Mitigation: Clear CPU buffers worker # [ 0.341640] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.343640] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 3.111320] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 0.344640] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.345647] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.346641] active return thunk: srso_alias_return_thunk worker # [ 0.347668] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.348641] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 3.120624] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.127105] systemd[1]: Mounting /sysroot/run... worker # [ 0.349640] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.351640] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.352640] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 3.132199] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 0.353640] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 3.381328] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 0.354640] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 3.383287] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 0.355640] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 3.387981] usb 1-1: Product: QEMU USB Tablet worker # [ 0.356640] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' worker # [ 0.358641] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 3.390834] usb 1-1: Manufacturer: QEMU worker # [ 0.359640] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 3.392851] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 0.360640] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 3.147241] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 0.362640] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.363641] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.364640] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 worker # [ 0.365640] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 worker # [ 0.366641] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 3.166105] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 0.401516] Freeing SMP alternatives memory: 44K worker # [ 0.402642] pid_max: default: 32768 minimum: 301 hub # [ 3.440335] hid: raw HID events driver (C) Jiri Kosina worker # [ 0.403744] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.405760] landlock: Up and running. worker # [ 0.407513] Yama: becoming mindful. worker # [ 0.408864] LSM support for eBPF active worker # [ 0.409739] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.411692] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.414997] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.416226] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.416650] ... version: 2 hub # [ 3.457939] 9p: Installing v9fs 9p2000 file system support worker # [ 0.417642] ... bit width: 48 worker # [ 0.418643] ... generic counters: 6 worker # [ 0.419642] ... generic bitmap: 000000000000003f worker # [ 0.420642] ... fixed-purpose counters: 0 worker # [ 0.421642] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.422642] ... value mask: 0000ffffffffffff hub # [ 3.219286] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 0.423642] ... max period: 00007fffffffffff worker # [ 0.424642] ... global_ctrl mask: 000000000000003f worker # [ 0.425772] signal: max sigframe size: 3376 worker # [ 0.426793] rcu: Hierarchical SRCU implementation. worker # [ 0.427647] rcu: Max phase no-delay instances is 400. hub # [ 3.478546] usbcore: registered new interface driver usbhid worker # [ 0.433323] smp: Bringing up secondary CPUs ... worker # [ 0.433659] smp: Brought up 1 node, 1 CPU hub # [ 3.234146] systemd-sysroot-fstab-check[132]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 0.434645] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) worker # [ 0.435880] Memory: 1969216K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved) worker # [ 0.436918] devtmpfs: initialized worker # [ 0.437800] x86/mm: Memory block size: 128MB hub # [ 3.491855] usbhid: USB HID core driver hub # [ 3.245202] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.246737] systemd[1]: Mounted /sysroot/run. worker # [ 0.439853] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.440677] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.441672] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.442751] pinctrl core: initialized pinctrl subsystem worker # [ 0.443944] PM: RTC time: 12:18:57, date: 2026-07-15 hub # [ 3.257329] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.258967] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 0.447532] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.449160] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.449670] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.450961] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 3.514094] 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.451654] audit: initializing netlink subsys (disabled) worker # [ 0.452933] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.452935] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 3.273118] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.453643] thermal_sys: Registered thermal governor 'step_wise' hub # [ 3.523179] 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.454647] audit: type=2000 audit(1784117936.813:1): state=initialized audit_enabled=0 res=1 worker # [ 0.456645] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.456647] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 3.280212] systemd[1]: Reload requested from client PID 132 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 0.457686] cpuidle: using governor menu hub # [ 3.283338] systemd[1]: Reloading... worker # [ 0.460806] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.461924] PCI: Using configuration type 1 for base access worker # [ 0.462642] PCI: Using configuration type 1 for extended access worker # [ 0.463871] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.468977] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.469643] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.470643] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.480642] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.488918] ACPI: Added _OSI(Module Device) worker # [ 0.489643] ACPI: Added _OSI(Processor Device) worker # [ 0.492584] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.497495] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.503883] ACPI: Interpreter enabled worker # [ 0.504659] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.505643] ACPI: Using IOAPIC for interrupt routing worker # [ 0.506662] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.509642] PCI: Using E820 reservations for host bridge windows worker # [ 0.510794] ACPI: Enabled 2 GPEs in block 00 to 0F worker # [ 0.518894] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.519649] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.521003] acpiphp: Slot [3] registered worker # [ 0.521685] acpiphp: Slot [4] registered worker # [ 0.522696] acpiphp: Slot [5] registered worker # [ 0.523685] acpiphp: Slot [6] registered worker # [ 0.524682] acpiphp: Slot [7] registered worker # [ 0.525685] acpiphp: Slot [8] registered worker # [ 0.526704] acpiphp: Slot [9] registered worker # [ 0.527683] acpiphp: Slot [10] registered worker # [ 0.528683] acpiphp: Slot [11] registered worker # [ 0.529697] acpiphp: Slot [12] registered worker # [ 0.530683] acpiphp: Slot [13] registered worker # [ 0.531676] acpiphp: Slot [14] registered worker # [ 0.532675] acpiphp: Slot [15] registered worker # [ 0.533693] acpiphp: Slot [16] registered worker # [ 0.534675] acpiphp: Slot [17] registered worker # [ 0.535675] acpiphp: Slot [18] registered worker # [ 0.536674] acpiphp: Slot [19] registered worker # [ 0.537689] acpiphp: Slot [20] registered worker # [ 0.538675] acpiphp: Slot [21] registered worker # [ 0.539683] acpiphp: Slot [22] registered worker # [ 0.540675] acpiphp: Slot [23] registered worker # [ 0.541692] acpiphp: Slot [24] registered worker # [ 0.542676] acpiphp: Slot [25] registered worker # [ 0.543675] acpiphp: Slot [26] registered hub # [ 3.394646] systemd[1]: Reloading finished in 115 ms. worker # [ 0.544692] acpiphp: Slot [27] registered worker # [ 0.545676] acpiphp: Slot [28] registered worker # [ 0.546697] acpiphp: Slot [29] registered worker # [ 0.547676] acpiphp: Slot [30] registered worker # [ 0.548694] acpiphp: Slot [31] registered worker # [ 0.549732] PCI host bridge to bus 0000:00 worker # [ 0.550660] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.551643] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 3.404984] systemd-sysroot-fstab-check[132]: Requesting initrd-fs.target/start/replace... worker # [ 0.552643] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.553643] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] hub # [ 3.409501] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.411595] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.554643] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] worker # [ 0.555643] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.557065] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint hub # [ 3.416815] systemd-sysroot-fstab-check[132]: Requesting swap.target/start/replace... worker # [ 0.558552] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 3.421968] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 0.560565] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint hub # [ 3.424574] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 0.563710] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f] hub # [ 3.427403] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 0.564707] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk worker # [ 0.565642] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk hub # [ 3.431094] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.566643] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk worker # [ 0.567642] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk worker # [ 0.568964] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.570710] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f] hub # [ 3.443312] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.572857] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint hub # [ 3.445886] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.574414] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI worker # [ 0.575657] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB worker # [ 0.577079] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.579773] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.580674] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.581695] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.582957] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.585053] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.587658] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] worker # [ 0.588658] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.589695] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.590657] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.593904] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.596657] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.597657] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.598696] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.601745] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.604438] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.605657] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.606696] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.609657] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.611659] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.613660] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.614696] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.617836] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.620818] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.621749] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.622756] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.625960] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.628680] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.629657] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.630695] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.633695] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.636605] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.637656] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.638695] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.639657] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.642656] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.644671] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.645696] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] worker # [ 0.648695] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.651579] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.652657] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.653696] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.656707] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.658683] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.659657] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.660696] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.669066] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.669860] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.670835] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.671837] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.672752] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 worker # [ 0.675076] iommu: Default domain type: Translated worker # [ 0.675654] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.676986] ACPI: bus type USB registered worker # [ 0.677703] usbcore: registered new interface driver usbfs worker # [ 0.678676] usbcore: registered new interface driver hub worker # [ 0.679653] usbcore: registered new device driver usb worker # [ 0.681716] NetLabel: Initializing worker # [ 0.682642] NetLabel: domain hash size = 128 worker # [ 0.683642] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.684693] NetLabel: unlabeled traffic allowed by default worker # [ 0.685660] PCI: Using ACPI for IRQ routing worker # [ 0.687367] pci 0000:00:02.0: vgaarb: setting as boot VGA device worker # [ 0.687637] pci 0000:00:02.0: vgaarb: bridge control possible worker # [ 0.687637] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.687646] vgaarb: loaded worker # [ 0.688944] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.689642] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.693764] clocksource: Switched to clocksource kvm-clock worker # [ 0.698609] VFS: Disk quotas dquot_6.6.0 worker # [ 0.699946] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.702415] pnp: PnP ACPI init worker # [ 0.704306] pnp: PnP ACPI: found 6 devices worker # [ 0.712991] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.715718] clocksource: Switched to clocksource acpi_pm worker # [ 0.717584] NET: Registered PF_INET protocol family worker # [ 0.719613] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.739094] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.741847] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.744207] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.746624] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) worker # [ 0.748902] TCP: Hash tables configured (established 16384 bind 16384) worker # [ 0.750925] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) worker # [ 0.753210] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.755235] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.757447] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.759257] NET: Registered PF_XDP protocol family worker # [ 0.760824] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.762685] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.764591] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.766686] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] worker # [ 0.768767] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] worker # [ 0.770957] pci 0000:00:01.0: PIIX3: Enabling Passive Release worker # [ 0.772806] pci 0000:00:00.0: Limiting direct PCI/PCI transfers worker # [ 0.776233] ACPI: \_SB_.LNKD: Enabled at IRQ 11 worker # [ 0.779733] PCI: CLS 0 bytes, default 64 worker # [ 0.781376] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns worker # [ 0.784490] Trying to unpack rootfs image as initramfs... worker # [ 0.832798] Initialise system trusted keyrings worker # [ 0.836984] workingset: timestamp_bits=40 max_order=19 bucket_order=0 worker # [ 0.863376] Key type asymmetric registered worker # [ 0.864709] Asymmetric key parser 'x509' registered worker # [ 0.869845] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.874864] io scheduler mq-deadline registered worker # [ 0.878792] io scheduler kyber registered worker # [ 0.882454] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.889185] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.897180] Linux agpgart interface v0.103 worker # [ 0.898570] ACPI: bus type drm_connector registered worker # [ 0.904261] usbcore: registered new interface driver usbserial_generic worker # [ 0.906245] usbserial: USB Serial support registered for generic worker # [ 0.911829] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. worker # [ 0.911829] Please enable it if your BIOS has the CPPC option. worker # [ 0.915845] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.923970] drop_monitor: Initializing network drop monitor service worker # [ 0.926081] NET: Registered PF_INET6 protocol family worker # [ 0.931357] Segment Routing with IPv6 worker # [ 0.934851] In-situ OAM (IOAM) with IPv6 worker # [ 0.938127] IPI shorthand broadcast: enabled worker # [ 0.947053] sched_clock: Marking stable (703029691, 243738019)->(1152661365, -205893655) hub # [ 3.918401] systemd[1]: Mounting /sysroot/nix/store... worker # [ 0.956116] registered taskstats version 1 worker # [ 0.957703] Loading compiled-in X.509 certificates worker # [ 0.980806] Demotion targets for Node 0: null worker # [ 0.984835] Key type .fscrypt registered worker # [ 0.986108] Key type fscrypt-provisioning registered worker # [ 0.990929] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.992652] ima: Allocated hash algorithm: sha1 worker # [ 0.997826] ima: No architecture policies found worker # [ 0.999505] PM: Magic number: 2:676:329 worker # [ 1.002810] tty tty50: hash matches hub # [ 3.969776] systemd[1]: Mounted /sysroot/nix/store. worker # [ 1.007103] RAS: Correctable Errors collector initialized. hub # [ 3.971942] systemd[1]: Reached target Initrd File Systems. hub # [ 3.977833] systemd[1]: Starting Find NixOS closure... worker # [ 1.018707] clk: Disabling unused clocks hub # [ 3.985599] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 1.021791] PM: genpd: Disabling unused power domains hub # [ 4.008487] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 4.013921] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 4.022155] systemd[1]: Finished Find NixOS closure. hub # [ 4.024911] systemd[1]: Reached target Initrd Default Target. hub # [ 4.026696] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 4.043320] systemd[1]: Stopped target Initrd Default Target. hub # [ 4.046210] systemd[1]: Stopped target Basic System. hub # [ 4.047639] systemd[1]: Stopped target Initrd Root Device. hub # [ 4.049154] systemd[1]: Stopped target Path Units. hub # [ 4.050633] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 4.053339] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 4.056393] systemd[1]: Stopped target Slice Units. hub # [ 4.057797] systemd[1]: Stopped target Socket Units. hub # [ 4.059226] systemd[1]: Stopped target System Initialization. hub # [ 4.061228] systemd[1]: Stopped target Swaps. hub # [ 4.063298] systemd[1]: Stopped target Timer Units. hub # [ 4.064699] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 4.066660] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.069204] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 4.071264] systemd[1]: Stopped Find NixOS closure. hub # [ 4.072887] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 4.076365] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.079191] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 4.080925] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.082362] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 4.084238] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.085899] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.088334] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.091199] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.093221] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.096185] systemd[1]: Stopped target Local File Systems. hub # [ 4.097687] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.099463] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 4.101359] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 4.104599] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.106482] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 4.109049] systemd[1]: Stopped Virtual Console Setup. hub # [ 4.116892] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.123149] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 4.134470] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 1.170945] Freeing initrd memory: 29528K hub # [ 4.137123] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 1.175235] Freeing unused decrypted memory: 2028K hub # [ 4.139289] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.142126] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 1.179163] Freeing unused kernel image (initmem) memory: 3636K hub # [ 4.144830] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 1.181079] Write protecting the kernel read-only data: 32768k hub # [ 4.147238] systemd[1]: Closed udev Control Socket. worker # [ 1.184007] Freeing unused kernel image (text/rodata gap) memory: 1272K hub # [ 4.149645] systemd[1]: Starting Cleanup udev Database... worker # [ 1.186552] Freeing unused kernel image (rodata/data gap) memory: 796K hub # [ 4.151252] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.154400] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.156259] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.158449] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.160979] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.162863] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 4.179562] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.181742] systemd[1]: Finished Cleanup udev Database. hub # [ 4.183973] systemd[1]: Reached target Switch Root. hub # [ 4.187107] systemd[1]: Starting NixOS Activation... worker # [ 1.239782] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.241728] Run /init as init process worker # [ 1.255056] systemd[1]: Inserted module 'autofs4' worker # [ 1.272717] fuse: init (API version 7.45) worker # [ 1.280522] ACPI: \_SB_.LNKC: Enabled at IRQ 10 worker # [ 1.289987] ACPI: \_SB_.LNKA: Enabled at IRQ 10 worker # [ 1.294893] ACPI: \_SB_.LNKB: Enabled at IRQ 11 worker # [ 1.336959] systemd[1]: Successfully made /usr/ read-only. hub # [ 4.355668] initrd-nixos-activation-start[183]: booting system configuration /nix/store/qiz4v4yb8dxdmad79hv2a9n0001vb0n1-nixos-system-hub-test hub # [ 4.419741] initrd-nixos-activation-start[183]: running activation script... worker # [ 1.676580] 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.698497] systemd[1]: Detected virtualization kvm. worker # [ 1.702517] systemd[1]: Detected architecture x86-64. worker # [ 1.706551] systemd[1]: Running in initrd. worker # [ 1.711020] systemd[1]: Initializing machine ID from random generator. worker # [ 1.716288] systemd[1]: Hostname set to . hub # [ 4.779366] initrd-nixos-activation-start[206]: setting up /etc... worker # [ 1.935039] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 1.996979] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 2.002590] systemd[1]: Created slice Slice /system/modprobe. worker # [ 2.006483] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 2.009152] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 2.011269] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 2.013319] systemd[1]: Reached target Path Units. worker # [ 2.014942] systemd[1]: Reached target Slice Units. worker # [ 2.016619] systemd[1]: Reached target Swaps. worker # [ 2.018175] systemd[1]: Reached target Timer Units. worker # [ 2.020003] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 2.022159] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 2.024227] systemd[1]: Listening on Journal Sockets. worker # [ 2.026009] systemd[1]: Listening on udev Control Socket. worker # [ 2.027893] systemd[1]: Listening on udev Kernel Socket. worker # [ 2.029617] systemd[1]: Reached target Socket Units. worker # [ 2.032863] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 2.039868] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 2.047990] systemd[1]: Starting Load Kernel Module configfs... worker # [ 2.065992] systemd[1]: Starting Journal Service... hub # [ 5.049196] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.051425] systemd[1]: Finished NixOS Activation. hub # [ 5.054372] systemd[1]: Starting Switch Root... worker # [ 2.081871] systemd[1]: Starting Load Kernel Modules... worker # [ 2.101066] netfs: FS-Cache loaded hub # [ 5.068206] systemd[1]: Switching root. worker # [ 2.106502] 9pnet: Installing 9P2000 support worker # [ 2.115203] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.127001] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.146912] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.151640] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 2.157537] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.168625] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.174424] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.180439] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.185974] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.192460] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.201546] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.221689] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 5.445664] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 2.241192] systemd[1]: Finished Load Kernel Modules. worker # [ 2.253318] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.273526] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.288270] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.308906] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.328696] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.336152] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.342898] systemd[1]: Reached target Local File Systems. worker # [ 2.352216] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.121302] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 2.125492] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 2.128454] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.373918] systemd[1]: Started Journal Service. hub # [ 5.602149] NET: Registered PF_VSOCK protocol family worker # [ 2.155650] systemd[1]: Starting Create System Files and Directories... worker # [ 2.191518] systemd[1]: Finished Create System Files and Directories. worker # [ 2.197340] systemd-udevd[74]: Using default interface naming scheme 'v261'. worker # [ 2.236677] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.288165] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.289786] systemd[1]: Reached target System Initialization. worker # [ 2.291384] systemd[1]: Reached target Basic System. hub # [ 5.993288] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) hub # [ 6.010341] systemd[1]: Detected virtualization kvm. hub # [ 6.013880] systemd[1]: Detected architecture x86-64. hub # [ 6.017208] systemd[1]: Detected first boot. hub # [ 6.024353] systemd[1]: Initializing machine ID from random generator. worker # [ 2.820089] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.858944] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.882536] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.890572] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.899263] uhci_hcd 0000:00:01.2: UHCI Host Controller worker # [ 2.900541] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 worker # [ 2.915517] SCSI subsystem initialized worker # [ 2.926261] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # [ 2.930794] uhci_hcd 0000:00:01.2: detected 2 ports worker # [ 2.932225] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c140 hub # [ 6.158017] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.964845] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.966776] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.969340] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.739263] systemd[1]: Starting Virtual Console Setup... worker # [ 2.994583] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 3.003023] virtio_blk virtio5: [vdb] 2081864 512-byte logical blocks (1.07 GB/1017 MiB) worker # [ 3.015331] usb usb1: Product: UHCI Host Controller worker # [ 2.780806] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.787144] systemd[1]: Finished Virtual Console Setup. worker # [ 2.791345] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.795236] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.041860] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd worker # [ 2.803681] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.055257] usb usb1: SerialNumber: 0000:00:01.2 worker # [ 3.060471] hub 1-0:1.0: USB hub found worker # [ 3.066446] hub 1-0:1.0: 2 ports detected hub # [ 6.286614] systemd[1]: Applying preset policy. worker # [ 2.865840] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 3.115006] scsi host0: ata_piix worker # [ 2.878161] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.880223] systemd[1]: Reached target Initrd Root Device. worker # [ 3.126551] scsi host1: ata_piix worker # [ 2.883921] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 3.130868] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 0 worker # [ 3.143878] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 0 worker # [ 2.916381] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.924535] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.930160] systemd[1]: Mounting /sysroot... worker # [ 3.293959] usb 1-1: new full-speed USB device number 2 using uhci_hcd worker # [ 3.303089] ata2: found unknown device (class 0) worker # [ 3.308089] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.316850] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.382515] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.405209] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.424624] EXT4-fs (vda): mounted filesystem 931ebe91-e5db-4765-a886-fc7eb2f6567c r/w with ordered data mode. Quota mode: none. worker # [ 3.190384] systemd[1]: Mounted /sysroot. worker # [ 3.193097] systemd[1]: Reached target Initrd Root File System. worker # [ 3.200111] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 3.205449] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.211206] systemd[1]: Mounting /sysroot/run... worker # [ 3.220702] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.466761] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.469827] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.475768] usb 1-1: Product: QEMU USB Tablet worker # [ 3.235084] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 3.481768] usb 1-1: Manufacturer: QEMU worker # [ 3.484768] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 3.255115] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 3.529904] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.307811] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.565993] usbcore: registered new interface driver usbhid worker # [ 3.574028] usbhid: USB HID core driver worker # [ 3.581827] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 3.349107] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.350610] systemd[1]: Mounted /sysroot/run. hub # [ 6.807195] systemd[1]: Populated /etc with preset unit settings. worker # [ 3.598791] 9p: Installing v9fs 9p2000 file system support worker # [ 3.358920] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.368755] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.370519] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.617817] 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.379101] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.381874] systemd[1]: Reloading... worker # [ 3.633176] 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.488794] systemd[1]: Reloading finished in 110 ms. worker # [ 3.499829] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace... worker # [ 3.506596] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace... worker # [ 3.509911] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.512478] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.515248] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.519597] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.533066] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.535794] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 7.307398] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 7.309951] systemd[1]: Stopped initrd-switch-root.service. hub # [ 7.313625] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 7.316899] systemd[1]: Created slice Slice /system/getty. hub # [ 7.318979] systemd[1]: Created slice User and Session Slice. hub # [ 7.320547] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 7.322622] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 7.324526] systemd[1]: Expecting device /dev/hvc0... hub # [ 7.325857] systemd[1]: Expecting device /dev/ttyS0... hub # [ 7.327198] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 7.328641] systemd[1]: Stopped target initrd-fs.target. hub # [ 7.330009] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 7.331425] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 7.332943] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 7.334578] systemd[1]: Reached target Path Units. hub # [ 7.335885] systemd[1]: Reached target Remote File Systems. hub # [ 7.337307] systemd[1]: Reached target Slice Units. hub # [ 7.338598] systemd[1]: Reached target Swaps. hub # [ 7.342514] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 7.347047] systemd[1]: Listening on Process Core Dump Socket. hub # [ 7.350449] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 7.353829] systemd[1]: Listening on Factory Reset Management. hub # [ 7.355450] systemd[1]: Listening on Hostname Service Socket. worker # [ 3.900472] systemd[1]: Mounting /sysroot/nix/store... hub # [ 7.360192] systemd[1]: Starting Journal Log Access Socket... hub # [ 7.362529] systemd[1]: Listening on Journal Audit Socket. hub # [ 7.366400] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 7.368280] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 7.370373] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.372726] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 7.382412] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 7.384479] systemd[1]: Listening on udev Control Socket. hub # [ 7.386076] systemd[1]: Listening on udev Varlink Socket. hub # [ 7.390470] systemd[1]: Mounting Huge Pages File System... hub # [ 7.394901] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 7.402905] systemd[1]: Mounting Kernel Debug File System... worker # [ 3.953087] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.954571] systemd[1]: Reached target Initrd File Systems. hub # [ 7.410339] systemd[1]: Mounting Kernel Trace File System... worker # [ 3.957413] systemd[1]: Starting Find NixOS closure... worker # [ 3.960723] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 7.421525] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 7.423470] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 7.435973] systemd[1]: Starting Load Kernel Module configfs... hub # [ 7.439235] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 3.984571] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 7.441990] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 3.990113] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 7.449577] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 3.998161] systemd[1]: Finished Find NixOS closure. worker # [ 4.000382] systemd[1]: Reached target Initrd Default Target. worker # [ 4.003655] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 4.022341] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 4.025117] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 4.029182] systemd[1]: Stopped target Initrd Default Target. worker # [ 4.030797] systemd[1]: Stopped target Basic System. worker # [ 4.033267] systemd[1]: Stopped target Initrd Root Device. worker # [ 4.034781] systemd[1]: Stopped target Path Units. worker # [ 4.036225] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 4.039164] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 4.041210] systemd[1]: Stopped target Slice Units. worker # [ 4.042660] systemd[1]: Stopped target Socket Units. worker # [ 4.045239] systemd[1]: Stopped target System Initialization. worker # [ 4.046780] systemd[1]: Stopped target Swaps. worker # [ 4.048085] systemd[1]: Stopped target Timer Units. hub # [ 7.505332] systemd[1]: Mounting FUSE Control File System... worker # [ 4.050194] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.051807] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 4.053391] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 4.056178] systemd[1]: Stopped Find NixOS closure. worker # [ 4.057555] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 4.060297] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 7.515018] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 4.062964] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 4.064784] systemd[1]: Stopped Apply Kernel Variables. worker # [ 4.066959] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 4.069413] systemd[1]: Stopped Load Kernel Modules. worker # [ 4.072260] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 7.531988] systemd[1]: Starting Journal Service... worker # [ 4.076187] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 4.078324] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 4.080400] systemd[1]: Stopped Create System Files and Directories. hub # [ 7.538859] systemd[1]: Starting Load Kernel Modules... worker # [ 4.084218] systemd[1]: Stopped target Local File Systems. worker # [ 4.085764] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 4.088357] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 4.091261] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 4.093173] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 4.095574] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 7.552557] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 4.098541] systemd[1]: Stopped Virtual Console Setup. worker # [ 4.106124] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 4.109113] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 7.565238] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 4.112321] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 4.115112] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 4.117980] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 7.573673] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 4.121203] systemd[1]: Closed udev Control Socket. worker # [ 4.123114] systemd[1]: Starting Cleanup udev Database... worker # [ 4.125215] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 4.127205] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 4.129091] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 4.131904] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 4.133779] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 4.137213] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 7.592912] systemd[1]: Starting Coldplug All udev Devices... hub # [ 7.599456] systemd-journald[276]: Collecting audit messages is enabled. worker # [ 4.152933] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 4.155840] systemd[1]: Finished Cleanup udev Database. worker # [ 4.157969] systemd[1]: Reached target Switch Root. worker # [ 4.160667] systemd[1]: Starting NixOS Activation... hub # [ 7.621928] loop: module loaded hub # [ 7.625821] systemd[1]: Listening on Journal Log Access Socket. hub # [ 7.635616] systemd[1]: Mounted Huge Pages File System. hub # [ 7.649077] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 7.655957] systemd[1]: Mounted Kernel Debug File System. hub # [ 7.663798] EXT4-fs (vda): re-mounted a21bc524-698c-408d-a6b2-0af2a3857541. hub # [ 7.666829] systemd[1]: Mounted Kernel Trace File System. worker # [ 4.214248] initrd-nixos-activation-start[183]: booting system configuration /nix/store/gcjgvnd3nai9585v6jgrnbs5p1103pqh-nixos-system-worker-test hub # [ 7.679724] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 7.436227] systemd[1]: Queued start job for default target Multi-User System.[ 7.687152] systemd[1]: Started Journal Service. hub # worker # [ 4.234667] initrd-nixos-activation-start[183]: running activation script... hub # [ 7.442674] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 7.446901] systemd-modules-load[277]: Inserted module 'loop' hub # [ 7.451751] systemd-modules-load[277]: Inserted module 'tls' hub # [ 7.455548] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 7.463125] systemd[1]: Finished Load Kernel Module configfs. hub # [ 7.468225] systemd[1]: Mounted FUSE Control File System. hub # [ 7.472102] systemd[1]: Finished Load Kernel Modules. hub # [ 7.475138] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 7.494111] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 7.499162] systemd-oomd[279]: No swap; memory pressure usage will be degraded hub # [ 7.507149] systemd[1]: Mounting Kernel Configuration File System... hub # [ 7.514120] systemd[1]: Starting Firewall... hub # [ 7.528133] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 7.529941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 7.542206] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 7.556818] systemd[1]: Starting Apply Kernel Variables... hub # [ 7.579130] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 7.583088] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 4.374987] initrd-nixos-activation-start[206]: setting up /etc... hub # [ 7.592379] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 7.863114] systemd-journald[276]: Received client request to flush runtime journal. worker # [ 4.452269] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.456143] systemd[1]: Finished NixOS Activation. worker # [ 4.459203] systemd[1]: Starting Switch Root... worker # [ 4.474155] systemd[1]: Switching root. worker # [ 4.845608] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 7.839656] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 7.848318] systemd[1]: Mounted Kernel Configuration File System. hub # [ 7.852525] systemd[1]: Reached target First Boot Complete. hub # [ 7.854856] systemd[1]: Finished Apply Kernel Variables. hub # [ 7.858097] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 7.861262] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 7.863575] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 7.890917] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 7.894572] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 4.930900] NET: Registered PF_VSOCK protocol family hub # [ 7.900520] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 7.966370] systemd[1]: Finished Coldplug All udev Devices. hub # [ 7.997621] systemd-udevd[319]: Using default interface naming scheme 'v261'. hub # [ 8.065571] systemd[1]: Mounting /run/wrappers... hub # [ 8.111082] systemd[1]: Mounted /run/wrappers. hub # [ 8.114373] systemd[1]: Reached target Local File Systems. hub # [ 8.118439] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 8.123384] systemd[1]: Starting register-nix-paths.service... hub # [ 8.129739] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 8.132259] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 8.143891] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 8.157399] systemd[1]: Starting Create System Files and Directories... hub # [ 8.163607] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 8.231256] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 8.241191] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 5.288992] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) worker # [ 5.305691] systemd[1]: Detected virtualization kvm. worker # [ 5.308922] systemd[1]: Detected architecture x86-64. worker # [ 5.312488] systemd[1]: Detected first boot. worker # [ 5.316373] systemd[1]: Initializing machine ID from random generator. hub # [ 8.325612] systemd[1]: Finished Create System Files and Directories. hub # [ 8.340664] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 8.354262] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 8.433320] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 8.494834] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 8.504839] systemd[1]: Starting Update is Completed... worker # [ 5.559083] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 8.560430] systemd[1]: Finished Update is Completed. worker # [ 5.676067] systemd[1]: Applying preset policy. hub # [ 8.719365] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.792554] systemd[1]: Populated /etc with preset unit settings. hub # [ 8.852460] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 8.856536] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 5.900296] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.902631] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.906173] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.909290] systemd[1]: Created slice Slice /system/getty. worker # [ 5.911379] systemd[1]: Created slice User and Session Slice. worker # [ 5.912968] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 5.915012] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.916884] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.918199] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.919558] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.921079] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.922438] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.923901] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.925448] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.927165] systemd[1]: Reached target Path Units. worker # [ 5.928464] systemd[1]: Reached target Remote File Systems. worker # [ 5.929925] systemd[1]: Reached target Slice Units. worker # [ 5.931242] systemd[1]: Reached target Swaps. worker # [ 5.933311] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.936179] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.938250] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.940508] systemd[1]: Listening on Factory Reset Management. worker # [ 5.942183] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.945295] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.947547] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.950798] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 5.952677] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.954622] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.956883] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 5.960545] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.962334] systemd[1]: Listening on udev Control Socket. worker # [ 5.963921] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.967209] systemd[1]: Mounting Huge Pages File System... worker # [ 5.973831] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 5.984144] systemd[1]: Mounting Kernel Debug File System... worker # [ 5.993829] systemd[1]: Mounting Kernel Trace File System... hub # [ 8.961109] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 6.009812] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 6.017564] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 6.031249] systemd[1]: Starting Load Kernel Module configfs... worker # [ 6.034839] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 6.037845] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.040476] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 9.011196] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 6.048459] systemd[1]: Mounting FUSE Control File System... worker # [ 6.055006] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.065534] systemd[1]: Starting Journal Service... worker # [ 6.073578] systemd[1]: Starting Load Kernel Modules... worker # [ 6.084965] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 6.103762] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 9.069242] (udev-worker)[412]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 6.114881] loop: module loaded hub # [ 9.078874] (udev-worker)[412]: Network interface NamePolicy= disabled on kernel command line. worker # [ 6.116296] systemd-journald[276]: Collecting audit messages is enabled. worker # [ 6.118824] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 9.084612] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line. worker # [ 6.133864] systemd[1]: Starting Coldplug All udev Devices... worker # [ 6.151750] EXT4-fs (vda): re-mounted 931ebe91-e5db-4765-a886-fc7eb2f6567c. hub # [ 9.129283] systemd[1]: Finished register-nix-paths.service. worker # [ 6.166146] systemd[1]: Listening on Journal Log Access Socket. hub # [ 9.133950] systemd[1]: Reached target System Initialization. worker # [ 6.171952] systemd[1]: Mounted Huge Pages File System. hub # [ 9.137758] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 9.139964] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 6.179059] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 9.142945] systemd[1]: Reached target Timer Units. hub # [ 9.146234] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 9.148796] systemd[1]: Listening on Nix Daemon Socket. worker # [ 5.941603] systemd[1]: Queued start job for default target Multi-User System.[ 6.187113] systemd[1]: Started Journal Service. worker # hub # [ 9.151755] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 5.945455] systemd[1]: Unnecessary job was removed for /dev/vdb. hub # [ 9.155046] systemd[1]: Reached target Socket Units. hub # [ 9.157255] systemd[1]: Reached target Basic System. worker # [ 5.949675] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 9.161763] systemd[1]: Started backdoor.service. worker # [ 5.957151] systemd-modules-load[277]: Inserted module 'loop' hub # [ 9.167328] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 5.960192] systemd[1]: Mounted Kernel Debug File System. worker # [ 5.964465] systemd[1]: Mounted Kernel Trace File System. worker # [ 5.967447] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 5.970564] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 9.181900] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 5.974549] systemd[1]: Finished Load Kernel Module configfs. worker # [ 5.978537] systemd[1]: Mounted FUSE Control File System. worker # [ 5.982591] systemd[1]: Finished Load Kernel Modules. worker # [ 5.988134] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 9.201152] systemd[1]: Starting Post-Boot Actions... worker # [ 5.998208] systemd-oomd[279]: No swap; memory pressure usage will be degraded worker # [ 6.006108] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 6.013381] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 9.222961] systemd[1]: Started Reset console on configuration changes. worker # [ 6.018867] systemd[1]: Mounting Kernel Configuration File System... worker # [ 6.029101] systemd[1]: Starting Firewall... hub # [ 9.245189] systemd[1]: Starting resolvconf update... worker # [ 6.037103] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 6.039212] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 6.049622] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 6.065103] systemd[1]: Starting Apply Kernel Variables... worker # [ 6.085152] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 6.087200] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # connecting to host... hub # [ 9.318394] systemd[1]: Finished Post-Boot Actions. hub # [ 9.327716] systemd[1]: Finished Firewall. hub # [ 9.334332] nsncd[499]: Jul 15 12:19:02.725 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.344964] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 6.383986] systemd-journald[276]: Received client request to flush runtime journal. hub: Guest shell says: b'Spawning backdoor root shell...\n' hub # [ 9.362208] systemd[1]: Reached target Host and Network Name Lookups. hub: connected to guest root shell hub # [ 9.365142] systemd[1]: Reached target User and Group Name Lookups. hub: (connecting took 7.09 seconds) hub: (finished: waiting for the VM to finish booting, in 7.09 seconds) hub # [ 9.377613] systemd[1]: Starting D-Bus System Message Bus... hub # [ 9.402633] systemd[1]: Starting User Login Management... hub # [ 9.410733] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 9.434678] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 9.560498] dbus-broker-launch[535]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 9.575854] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 9.578660] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 6.372423] systemd[1]: Mounted Kernel Configuration File System. hub # [ 9.583235] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 9.587214] systemd[1]: Stopping User and Group Name Lookups... worker # [ 6.380153] systemd[1]: Finished Apply Kernel Variables. hub # [ 9.589328] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 6.382330] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 9.594395] dbus-broker-launch[535]: NSS returned no entry for 'systemd-timesync' worker # [ 6.388313] systemd[1]: Reached target First Boot Complete. hub # [ 9.597248] dbus-broker-launch[535]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 6.391276] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 6.394553] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 9.602272] systemd[1]: nscd.service: Deactivated successfully. worker # [ 6.398218] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 9.606165] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 6.400753] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 6.404241] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 6.406385] systemd-udevd[316]: Using default interface naming scheme 'v261'. worker # [ 6.410285] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 9.627404] systemd-logind[539]: New seat seat0. hub # [ 9.633121] systemd[1]: Started User Login Management. hub # [ 9.644216] systemd[1]: Starting linger-users.service... hub # [ 9.658361] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 9.660551] systemd[1]: Started D-Bus System Message Bus. worker # [ 6.471233] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 9.708396] dbus-broker-launch[535]: Ready worker # [ 6.520927] systemd[1]: Finished Coldplug All udev Devices. hub # [ 9.746951] systemd[1]: Finished resolvconf update. hub # [ 9.752111] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 9.755412] systemd[1]: Finished linger-users.service. hub # [ 9.759895] systemd[1]: Reached target Preparation for Network. hub # [ 9.766332] nsncd[595]: Jul 15 12:19:03.161 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.774323] systemd[1]: Starting DHCP Client... hub # [ 9.782143] systemd[1]: Starting Address configuration of eth1... hub # [ 9.793456] systemd[1]: Starting Extra networking commands.... hub # [ 9.807282] systemd[1]: Starting Tailscale node agent... hub # [ 9.814766] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 9.852820] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 9.854561] systemd[1]: Reached target User and Group Name Lookups. worker # [ 6.666262] systemd[1]: Mounting /run/wrappers... worker # [ 6.695397] systemd[1]: Mounted /run/wrappers. worker # [ 6.698106] systemd[1]: Reached target Local File Systems. worker # [ 6.702943] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 10.161218] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.711122] systemd[1]: Starting register-nix-paths.service... worker # [ 6.722111] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 6.723831] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 6.739111] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 9.948753] network-addresses-eth1-start[616]: adding address 192.168.1.1/24... done worker # [ 6.755347] systemd[1]: Starting Create System Files and Directories... hub # [ 9.981918] network-addresses-eth1-start[616]: adding address 2001:db8:1::1/64... done worker # [ 6.798886] systemd[1]: Finished Firewall. hub # [ 10.016957] systemd[1]: Finished Address configuration of eth1. worker # [ 6.818174] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 6.829855] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 10.306997] ACPI: button: Power Button [PWRF] worker # [ 6.881571] systemd[1]: Finished Create System Files and Directories. worker # [ 6.893178] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 10.350435] rtc_cmos 00:05: RTC can wake from S4 hub # [ 10.356924] mousedev: PS/2 mouse device common for all mice worker # [ 6.904843] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 10.372281] parport_pc 00:03: reported by Plug and Play ACPI worker # [ 6.920169] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 10.135806] systemd[1]: Finished Extra networking commands.. hub # [ 10.139334] systemd[1]: Reached target Network. hub # [ 10.149801] dhcpcd[634]: dhcpcd-10.3.2 starting hub # [ 10.401457] Floppy drive(s): fd0 is 2.88M AMI BIOS hub # [ 10.159061] systemd[1]: Starting Nginx Web Server... hub # [ 10.166581] systemd[1]: Starting Permit User Sessions... hub # [ 10.175368] dhcpcd[682]: dev: loaded udev hub # [ 10.434049] rtc_cmos 00:05: registered as rtc0 worker # [ 6.991152] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 10.460922] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 10.466890] 8021q: 802.1Q VLAN Support v1.8 hub # [ 10.482503] rtc_cmos 00:05: setting system clock to 2026-07-15T12:19:03 UTC (1784117943) hub # [ 10.486152] systemd-journald[276]: Time jumped backwards, rotating. worker # [ 7.031899] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.045961] systemd[1]: Starting Update is Completed... hub # [ 10.515287] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 10.537114] FDC 0 is a S82078B hub # [ 10.550056] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 7.095790] systemd[1]: Finished Update is Completed. hub # [ 10.322169] systemd[1]: Finished Permit User Sessions. hub # [ 10.336304] systemd[1]: Started Getty on tty1. hub # [ 10.339614] systemd[1]: Reached target Login Prompts. hub # [ 10.387506] tailscaled[618]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 7.208120] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 7.213135] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 10.421776] tailscaled[618]: logtail started worker # [ 7.219813] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. hub # [ 10.425789] 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 # [ 10.432118] tailscaled[618]: LogID: 7229bc3320a5f249e6317f8c5249d1857aafdceeabed476a23f3f758f4d03463 hub # [ 10.435132] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 10.437181] tailscaled[618]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 10.441477] tailscaled[618]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil hub # [ 10.488440] tailscaled[618]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:45174->[::1]:53: read: connection refused (in 20ms), trying bootstrap... worker # [ 7.293712] (udev-worker)[401]: Network interface NamePolicy= disabled on kernel command line. worker # [ 7.298278] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 10.510459] tailscaled[618]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... hub # [ 10.520317] 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 # [ 7.314344] (udev-worker)[408]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 10.525076] tailscaled[618]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... worker # [ 7.320048] (udev-worker)[408]: Network interface NamePolicy= disabled on kernel command line. hub # [ 10.527736] 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 # [ 10.534267] tailscaled[618]: trying bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" ... hub # [ 10.536938] tailscaled[618]: bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 208.111.34.178:443: connect: network is unreachable hub # [ 10.543175] tailscaled[618]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ... hub # [ 10.547329] tailscaled[618]: bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::29:9001]:443: connect: network is unreachable hub # [ 10.554107] tailscaled[618]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... hub # [ 10.556675] tailscaled[618]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable hub # [ 10.562385] tailscaled[618]: trying bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" ... hub # [ 10.566211] tailscaled[618]: bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::44c]:443: connect: network is unreachable worker # [ 7.366156] systemd[1]: Finished register-nix-paths.service. hub # [ 10.572906] tailscaled[618]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ... worker # [ 7.367819] systemd[1]: Reached target System Initialization. worker # [ 7.371108] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 7.373260] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 10.579146] tailscaled[618]: bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 45.63.71.144:443: connect: network is unreachable worker # [ 7.377244] systemd[1]: Reached target Timer Units. hub # [ 10.583862] tailscaled[618]: trying bootstrapDNS("derp10.tailscale.com", "2001:19f0:8001:2d9:5400:2ff:feef:bbb1") for "log.tailscale.com" ... worker # [ 7.379328] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 7.381058] systemd[1]: Listening on Nix Daemon Socket. worker # [ 7.382580] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 10.586709] tailscaled[618]: 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 # [ 7.386336] systemd[1]: Listening on tribuchet-sandboxd.socket. hub # [ 10.593050] tailscaled[618]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... worker # [ 7.387957] systemd[1]: Reached target Socket Units. worker # [ 7.389411] systemd[1]: Reached target Basic System. worker # [ 7.392275] systemd[1]: Started backdoor.service. hub # [ 10.596838] 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 hub # [ 10.602062] tailscaled[618]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ... worker # [ 7.400723] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 10.605992] 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 # [ 10.613190] tailscaled[618]: trying bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" ... worker # [ 7.410296] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 10.615693] tailscaled[618]: bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 155.138.243.219:443: connect: network is unreachable hub # [ 10.621394] tailscaled[618]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... worker # [ 7.425181] systemd[1]: Starting Post-Boot Actions... hub # [ 10.631125] 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 hub # [ 10.636779] tailscaled[618]: logtail: upload: log upload of 476 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/880cafd8e67b425f02e70e0219757e7f90eb3c3adc81fc082cc40c1c22c5616f": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" hub # [ 10.650590] dbus-broker-launch[535]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 7.445852] systemd[1]: Started Reset console on configuration changes. hub # [ 10.909220] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 hub # [ 10.913067] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 10.919640] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 7.467859] systemd[1]: Starting resolvconf update... worker # connecting to host... hub # [ 10.704893] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 10.707615] tailscaled[618]: dns: using "openresolv" mode hub # [ 10.714535] tailscaled[618]: dns: using dns.openresolvManager hub # [ 10.965490] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 7.511153] systemd[1]: Finished Post-Boot Actions. hub # [ 10.970930] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 7.518358] nsncd[502]: Jul 15 12:19:04.120 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 10.978785] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 10.980843] cfg80211: failed to load regulatory.db worker # [ 7.529868] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 10.751402] nginx-pre-start[693]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok hub # [ 10.756848] nginx-pre-start[693]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful worker # [ 7.556171] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 7.559831] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 7.566097] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.567846] systemd[1]: Reached target User and Group Name Lookups. hub # [ 10.777353] systemd[1]: Started Nginx Web Server. worker # [ 7.575118] systemd[1]: Starting D-Bus System Message Bus... worker # [ 7.595351] systemd[1]: Starting User Login Management... hub # [ 10.876880] dhcpcd[682]: eth0: waiting for carrier hub # [ 10.879863] dhcpcd[682]: libudev: received NULL device hub # [ 10.882416] dhcpcd[682]: libudev: received NULL device hub # [ 10.886212] dhcpcd[682]: eth0: carrier acquired worker # [ 7.680404] dbus-broker-launch[531]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 7.682643] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 7.688859] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 7.690479] dbus-broker-launch[531]: NSS returned no entry for 'systemd-timesync' worker # [ 7.692342] dbus-broker-launch[531]: Invalid user-name in /nix/store/a7agjv2209jvj4cvwy8lz4g35l9gak1c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 7.698475] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 7.700196] systemd[1]: Stopping User and Group Name Lookups... worker # [ 7.703252] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 10.913238] dhcpcd[682]: DUID 00:01:00:01:31:ea:37:38:52:54:00:12:34:56 worker # [ 7.705844] systemd[1]: nscd.service: Deactivated successfully. hub # [ 10.915086] dhcpcd[682]: eth0: IAID 00:12:34:56 worker # [ 7.708319] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 10.916516] dhcpcd[682]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 7.713128] systemd[1]: nscd.service: Consumed 16ms CPU time over 277ms wall clock time, 6.8M memory peak, 5.5M read from disk. worker # [ 7.718647] systemd[1]: Started D-Bus System Message Bus. worker # [ 7.747550] dbus-broker-launch[531]: Ready worker # [ 7.751811] systemd-logind[539]: New seat seat0. worker # [ 7.758156] systemd[1]: Started User Login Management. hub # [ 11.008180] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 7.781115] systemd[1]: Starting linger-users.service... worker # [ 7.791063] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 11.068618] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 hub # [ 11.124083] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 11.142925] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 11.143330] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 7.832125] systemd[1]: Finished resolvconf update. hub # [ 11.230837] Console: switching to colour dummy device 80x25 hub # [ 11.292323] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 11.292326] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 7.837923] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 7.840247] systemd[1]: Finished linger-users.service. hub # [ 11.296292] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic hub # [ 11.305073] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 7.851406] nsncd[576]: Jul 15 12:19:04.453 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.863576] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.865863] systemd[1]: Reached target Preparation for Network. worker # [ 7.869414] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.871109] systemd[1]: Reached target User and Group Name Lookups. worker # [ 7.877386] systemd[1]: Starting DHCP Client... worker # [ 7.884727] systemd[1]: Starting Address configuration of eth1... worker # [ 7.896391] systemd[1]: Starting Extra networking commands.... hub # [ 11.331923] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 7.910359] systemd[1]: Starting Tailscale node agent... hub # [ 11.362685] Console: switching to colour frame buffer device 160x50 hub # [ 11.370089] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 8.159186] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 11.153835] systemd[1]: Started Tailscale node agent. hub # [ 11.157317] tailscaled[618]: wgengine.NewUserspaceEngine(tun "tailscale0") ... hub # [ 11.448256] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.010973] network-addresses-eth1-start[598]: adding address 192.168.1.2/24... done hub # [ 11.483048] kvm_amd: TSC scaling supported worker # [ 8.028078] network-addresses-eth1-start[598]: adding address 2001:db8:1::2/64... done hub # [ 11.493303] kvm_amd: Nested Virtualization enabled hub # [ 11.502956] kvm_amd: Nested Paging enabled hub # [ 11.258201] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 11.260429] tailscaled[618]: dns: using "openresolv" mode worker # [ 8.056261] systemd[1]: Finished Address configuration of eth1. hub # [ 11.519976] kvm_amd: LBR virtualization supported hub # [ 11.278308] tailscaled[618]: dns: using dns.openresolvManager hub # [ 11.280189] tailscaled[618]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} hub # [ 11.532906] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 11.293783] tailscaled[618]: magicsock: disco key = d:dc6a5c90ce4c5b39 hub # [ 11.295933] tailscaled[618]: Creating WireGuard device... hub # [ 11.300953] tailscaled[618]: Bringing WireGuard device up... hub # [ 11.303094] systemd[1]: Starting Virtual Console Setup... hub # [ 11.305993] tailscaled[618]: Bringing router up... hub # [ 11.559666] kvm_amd: Virtual GIF supported hub # [ 11.316616] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 11.318317] tailscaled[618]: router: using firewall mode pref worker # [ 8.353746] ACPI: button: Power Button [PWRF] hub # [ 11.332903] tailscaled[618]: external route: up hub # [ 11.587145] kvm_amd: Virtual NMI enabled hub # [ 11.381751] tailscaled[618]: router: default choosing iptables worker # [ 8.420185] rtc_cmos 00:05: RTC can wake from S4 worker # [ 8.181935] dhcpcd[614]: dhcpcd-10.3.2 starting worker # [ 8.196618] dhcpcd[658]: dev: loaded udev worker # [ 8.451069] 8021q: 802.1Q VLAN Support v1.8 worker # [ 8.458750] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.225370] systemd[1]: Finished Extra networking commands.. worker # [ 8.230795] systemd[1]: Reached target Network. hub # [ 11.438618] tailscaled[618]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 11.442217] tailscaled[618]: router: portUpdate(port=41641, network=udp4) worker # [ 8.238106] systemd[1]: Starting Permit User Sessions... hub # [ 11.451197] tailscaled[618]: Clearing router settings... hub # [ 11.453376] tailscaled[618]: Starting network monitor... worker # [ 8.248317] tailscaled[600]: TPM: error opening: stat /dev/tpmrm0: no such file or directory hub # [ 11.457517] tailscaled[618]: Engine created. worker # [ 8.503528] mousedev: PS/2 mouse device common for all mice worker # [ 8.269459] tailscaled[600]: logtail started worker # [ 8.270730] tailscaled[600]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} hub # [ 11.483713] tailscaled[618]: pm: migrating "_daemon" profile to new format worker # [ 8.276074] tailscaled[600]: LogID: 498562d5a1ec2e4d78ce08b2a5818a54a31a8bf209fad875b4cc0907f263cc70 worker # [ 8.278242] tailscaled[600]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 11.487133] tailscaled[618]: envknob: PORT="41641" worker # [ 8.283699] tailscaled[600]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 11.494532] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.287216] tailscaled[600]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil hub # [ 11.498985] tailscaled[618]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 11.505948] tailscaled[618]: got LocalBackend in 350ms hub # [ 11.507912] tailscaled[618]: Start hub # [ 11.509787] tailscaled[618]: ipnext: "conn25": skipping extension hub # [ 11.514375] tailscaled[618]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop hub # [ 11.522414] tailscaled[618]: profile data directory: profile not found worker # [ 8.312133] tailscaled[600]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:46547->[::1]:53: read: connection refused (in 13ms), trying bootstrap... worker # [ 8.560161] rtc_cmos 00:05: registered as rtc0 worker # [ 8.561435] rtc_cmos 00:05: setting system clock to 2026-07-15T12:19:05 UTC (1784117945) hub # [ 11.526631] tailscaled[618]: Backend: logs: be:7229bc3320a5f249e6317f8c5249d1857aafdceeabed476a23f3f758f4d03463 fe: worker # [ 8.320381] systemd[1]: Finished Permit User Sessions. hub # [ 11.530825] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 11.533470] tailscaled[618]: blockEngineUpdates(true) hub # [ 11.537275] tailscaled[618]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 8.330896] tailscaled[600]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... hub # [ 11.542955] tailscaled[618]: wgengine: Reconfig: configuring router worker # [ 8.581312] parport_pc 00:03: reported by Plug and Play ACPI hub # [ 11.546164] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 11.547892] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 11.550527] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 8.341131] tailscaled[600]: 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 hub # [ 11.553155] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 8.345750] tailscaled[600]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... hub # [ 11.555472] tailscaled[618]: dns: OScfg: {} worker # [ 8.348568] tailscaled[600]: bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c]:443: connect: network is unreachable worker # [ 8.353991] tailscaled[600]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... worker # [ 8.358174] tailscaled[600]: 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 worker # [ 8.362922] tailscaled[600]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ... worker # [ 8.365612] systemd[1]: Started Getty on tty1. worker # [ 8.370295] systemd[1]: Reached target Login Prompts. worker # [ 8.371699] tailscaled[600]: bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:100:d0::982:d001]:443: connect: network is unreachable worker # [ 8.376737] tailscaled[600]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... hub # [ 11.586229] systemd-logind[539]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 8.383203] tailscaled[600]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable hub # [ 11.594279] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. hub # [ 11.847481] ppdev: user-space parallel port driver worker # [ 8.393435] tailscaled[600]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ... worker # [ 8.395978] tailscaled[600]: bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::f4]:443: connect: network is unreachable worker # [ 8.400824] tailscaled[600]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ... worker # [ 8.403227] tailscaled[600]: bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 103.43.75.49:443: connect: network is unreachable worker # [ 8.410958] tailscaled[600]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... hub # [ 11.619824] systemd-logind[539]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 8.414314] tailscaled[600]: bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:1d9c:5400:2ff:feef:bb82]:443: connect: network is unreachable worker # [ 8.419855] dbus-broker-launch[531]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 8.425515] tailscaled[600]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ... worker # [ 8.672137] Floppy drive(s): fd0 is 2.88M AMI BIOS worker # [ 8.430180] tailscaled[600]: bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.90.120:443: connect: network is unreachable worker # [ 8.437079] tailscaled[600]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ... worker # [ 8.440154] tailscaled[600]: bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:100:d0::982:d001]:443: connect: network is unreachable worker # [ 8.445910] tailscaled[600]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ... worker # [ 8.453106] tailscaled[600]: bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 45.63.71.144:443: connect: network is unreachable worker # [ 8.457720] tailscaled[600]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ... worker # [ 8.460829] tailscaled[600]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60]:443: connect: network is unreachable worker # [ 8.467759] tailscaled[600]: logtail: upload: log upload of 354 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/385f7932bdcfc4e8f7557a4853c84c850d29fd88e0d7f335f8d4e54719b3527c": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" hub # [ 11.689850] dhcpcd[682]: eth0: soliciting a DHCP lease hub # [ 11.947835] EDAC MC: Ver: 3.0.0 worker # [ 8.493112] tailscaled[600]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.495080] tailscaled[600]: dns: using "openresolv" mode worker # [ 8.496460] tailscaled[600]: dns: using dns.openresolvManager hub # [ 11.706561] (udev-worker)[752]: Network interface NamePolicy= disabled on kernel command line. worker # [ 8.747640] FDC 0 is a S82078B hub # [ 11.965572] NET: Registered PF_PACKET protocol family worker # [ 8.753435] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 11.723766] dhcpcd[682]: eth0: offered 10.0.2.15 from 10.0.2.2 hub # [ 11.727281] dhcpcd[682]: eth0: probing address 10.0.2.15/24 hub # [ 11.735920] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 11.738179] systemd[1]: Stopped Virtual Console Setup. hub # [ 11.751391] systemd[1]: Starting Virtual Console Setup... worker # [ 8.786850] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 11.765447] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) hub # [ 11.780324] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 11.783285] systemd[1]: Stopped Virtual Console Setup. worker # [ 8.824270] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 11.794666] systemd[1]: Starting Virtual Console Setup... worker # [ 8.838715] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.842565] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.849956] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.852757] cfg80211: failed to load regulatory.db worker # [ 8.881865] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 8.905999] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 worker # [ 8.908657] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.671143] dhcpcd[658]: eth0: waiting for carrier worker # [ 8.687103] tailscaled[600]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 8.689751] systemd[1]: Started Tailscale node agent. worker # [ 8.942934] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.730224] tailscaled[600]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.732200] tailscaled[600]: dns: using "openresolv" mode worker # [ 8.739770] tailscaled[600]: dns: using dns.openresolvManager worker # [ 8.741347] tailscaled[600]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 8.747748] tailscaled[600]: magicsock: disco key = d:ff22ef8434c7b016 worker # [ 8.749789] tailscaled[600]: Creating WireGuard device... worker # [ 8.751476] tailscaled[600]: Bringing WireGuard device up... worker # [ 8.754377] tailscaled[600]: Bringing router up... worker # [ 8.756289] tailscaled[600]: router: using firewall mode pref worker # [ 8.759091] tailscaled[600]: router: portUpdate(port=41641, network=udp6) worker # [ 8.772370] tailscaled[600]: external route: up worker # [ 8.790873] tailscaled[600]: router: default choosing iptables worker # [ 8.813366] tailscaled[600]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 8.818981] tailscaled[600]: Clearing router settings... worker # [ 8.822193] tailscaled[600]: Starting network monitor... worker # [ 8.824085] tailscaled[600]: Engine created. worker # [ 8.827627] tailscaled[600]: router: portUpdate(port=41641, network=udp4) worker # [ 8.833253] tailscaled[600]: pm: migrating "_daemon" profile to new format worker # [ 8.835775] tailscaled[600]: envknob: PORT="41641" worker # [ 8.837063] tailscaled[600]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.838907] tailscaled[600]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 8.846499] tailscaled[600]: got LocalBackend in 160ms worker # [ 8.848083] tailscaled[600]: Start worker # [ 8.850543] tailscaled[600]: ipnext: "conn25": skipping extension worker # [ 8.853271] tailscaled[600]: ipnext: active extensions: relayserver, taildrop, conn25, portlist, posture, clientupdate worker # [ 8.858993] tailscaled[600]: profile data directory: profile not found worker # [ 8.860668] tailscaled[600]: Backend: logs: be:498562d5a1ec2e4d78ce08b2a5818a54a31a8bf209fad875b4cc0907f263cc70 fe: worker # [ 8.864102] tailscaled[600]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 8.866645] tailscaled[600]: blockEngineUpdates(true) worker # [ 8.869399] tailscaled[600]: wgengine: Reconfig: configuring router worker # [ 8.872193] tailscaled[600]: wgengine: Reconfig: user dialer worker # [ 8.873764] tailscaled[600]: wgengine: Reconfig: configuring DNS worker # [ 8.875314] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 8.879257] tailscaled[600]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 8.881550] tailscaled[600]: dns: OScfg: {} worker # [ 8.886072] tailscaled[600]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 8.972526] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 worker # [ 8.979796] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 9.009042] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 12.169764] systemd-vconsole-setup[789]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 12.175431] systemd[1]: Finished Virtual Console Setup. worker # [ 8.969764] systemd[1]: Starting Virtual Console Setup... worker # [ 8.988242] dhcpcd[658]: eth0: carrier acquired worker # [ 8.999287] dhcpcd[658]: DUID 00:01:00:01:31:ea:37:3a:52:54:00:12:34:56 worker # [ 9.001167] dhcpcd[658]: eth0: IAID 00:12:34:56 worker # [ 9.002571] dhcpcd[658]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 9.018336] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 9.158155] Console: switching to colour dummy device 80x25 worker # [ 9.289965] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 9.289967] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 9.034063] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 9.068630] systemd-logind[539]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 9.321295] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic worker # [ 9.322651] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 9.099820] systemd-logind[539]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 9.113506] systemd-vconsole-setup[725]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.361980] ppdev: user-space parallel port driver worker # [ 9.120361] systemd[1]: Finished Virtual Console Setup. worker # [ 9.143420] (udev-worker)[397]: Network interface NamePolicy= disabled on kernel command line. worker # [ 9.197111] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.201101] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.203332] systemd[1]: Stopping Virtual Console Setup... worker # [ 9.207337] systemd[1]: Starting Virtual Console Setup... worker # [ 9.453746] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 9.511149] Console: switching to colour frame buffer device 160x50 worker # [ 9.515946] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 9.242315] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 9.279556] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.281855] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.295246] systemd[1]: Starting Virtual Console Setup... worker # [ 9.342697] systemd-vconsole-setup[735]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.349464] systemd[1]: Finished Virtual Console Setup. worker # [ 9.640062] kvm_amd: TSC scaling supported worker # [ 9.644640] kvm_amd: Nested Virtualization enabled worker # [ 9.645968] kvm_amd: Nested Paging enabled worker # [ 9.648117] kvm_amd: LBR virtualization supported worker # [ 9.651258] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 9.654425] kvm_amd: Virtual GIF supported worker # [ 9.656839] kvm_amd: Virtual NMI enabled worker # [ 9.698340] EDAC MC: Ver: 3.0.0 hub # [ 12.830552] dhcpcd[682]: eth0: soliciting an IPv6 router hub # [ 12.836684] dhcpcd[682]: eth0: Router Advertisement from fe80::2 hub # [ 12.841530] dhcpcd[682]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 12.848395] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 12.855217] dhcpcd[682]: eth0: adding route to fec0::/64 hub # [ 12.860438] dhcpcd[682]: eth0: adding default route via fe80::2 hub # [ 12.868618] 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::7ec8:b370:cda:5803/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::7ec8:b370:cda:5803/64] rebind-reason=[default-if-changed] hub # [ 12.891633] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 12.895747] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 12.900167] tailscaled[618]: dns: OScfg: {} worker # [ 9.696944] dhcpcd[658]: eth0: soliciting a DHCP lease hub # [ 12.906215] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 9.955418] NET: Registered PF_PACKET protocol family worker # [ 9.718943] dhcpcd[658]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 9.724580] dhcpcd[658]: eth0: probing address 10.0.2.15/24 hub # [ 12.950603] tailscaled[618]: wgengine: set DNS config again after major link change hub # [ 12.953339] tailscaled[618]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7ec8:b370:cda:5803/64] hub # [ 12.956529] tailscaled[618]: magicsock: 0 active derp conns hub # [ 12.959445] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 12.961421] tailscaled[618]: router: portUpdate(port=41641, network=udp4) hub # [ 14.134929] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub # [ 14.647132] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::7ec8:b370:cda:5803/128, gw=, outif=2, table=255 worker # [ 11.483355] dhcpcd[658]: eth0: soliciting an IPv6 router worker # [ 11.490398] dhcpcd[658]: eth0: Router Advertisement from fe80::2 worker # [ 11.495148] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 11.502307] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 11.508428] dhcpcd[658]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 11.513465] dhcpcd[658]: eth0: adding route to fec0::/64 worker # [ 11.518674] dhcpcd[658]: eth0: adding default route via fe80::2 worker # [ 11.528380] tailscaled[600]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/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::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/64] rebind-reason=[default-if-changed] worker # [ 11.549780] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 11.554451] tailscaled[600]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 11.557947] tailscaled[600]: dns: OScfg: {} worker # [ 11.572127] tailscaled[600]: wgengine: set DNS config again after major link change worker # [ 11.574074] tailscaled[600]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/64] worker # [ 11.576836] tailscaled[600]: magicsock: 0 active derp conns worker # [ 11.579339] tailscaled[600]: router: portUpdate(port=41641, network=udp6) worker # [ 11.581353] tailscaled[600]: router: portUpdate(port=41641, network=udp4) worker # [ 12.727398] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=fec0::d69c:9192:2567:ea4c/128, gw=, outif=2, table=255 worker # [ 12.919268] tailscaled[600]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub # [ 17.200189] dhcpcd[682]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 17.207627] dhcpcd[682]: eth0: adding route to 10.0.2.0/24 hub # [ 17.213651] dhcpcd[682]: eth0: adding default route via 10.0.2.2 hub # [ 17.220564] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 17.228065] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 17.230509] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 17.233443] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 17.239903] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::7ec8:b370:cda:5803/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::7ec8:b370:cda:5803/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::7ec8:b370:cda:5803/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7ec8:b370:cda:5803/64] rebind-reason=[ips-changed] hub # [ 17.268728] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 17.270845] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 17.274453] tailscaled[618]: dns: OScfg: {} hub # [ 17.377372] systemd[1]: Started DHCP Client. hub # [ 17.380714] systemd[1]: Reached target Network is Online. hub # [ 17.386417] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 17.389155] systemd[1]: Reached target Multi-User System. hub # [ 17.391264] systemd[1]: Startup finished in 996ms (kernel) + 4.294s (initrd) + 12.099s (userspace) = 17.390s. hub: (finished: waiting for unit headscale, in 15.18 seconds) hub: waiting for TCP port 443 on localhost hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.07 seconds) hub: waiting for unit tailscaled hub: (finished: waiting for unit tailscaled, in 0.08 seconds) worker: waiting for unit tailscaled worker: waiting for the VM to finish booting worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 0.00 seconds) worker: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker: (finished: waiting for unit tailscaled, in 0.04 seconds) hub: must succeed: headscale users create test hub # [ 17.758186] headscale-start[898]: 2026-07-15T12:19:11Z WRN hub # [ 17.759739] headscale-start[898]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed. hub # [ 17.773525] headscale-start[898]: 2026-07-15T12:19:11Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 17.778245] headscale-start[898]: 2026-07-15T12:19:11Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 17.875987] headscale-start[898]: 2026-07-15T12:19:11Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 17.885898] headscale-start[898]: 2026-07-15T12:19:11Z INF starting headscale commit=v0.29.2 version=0.29.2 hub # [ 17.888312] headscale-start[898]: 2026-07-15T12:19:11Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 17.892092] headscale-start[898]: 2026-07-15T12:19:11Z 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:[0x1c2f55d1c120]} hub # [ 17.897274] headscale-start[898]: 2026-07-15T12:19:11Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:145 > derp nodes[0]: &{Name:999 RegionID:999 HostName:hub CertName: IPv4: IPv6: STUNPort:3478 STUNOnly:false DERPPort:443 InsecureForTests:false STUNTestIP: CanPort80:false} hub # [ 17.909986] headscale-start[898]: 2026-07-15T12:19:11Z INF stun server started at [::]:3478 hub # [ 17.914056] headscale-start[898]: 2026-07-15T12:19:11Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 17.918552] headscale-start[898]: 2026-07-15T12:19:11Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 17.923274] headscale-start[898]: 2026-07-15T12:19:11Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 17.925643] headscale-start[898]: 2026-07-15T12:19:11Z INF metrics server disabled (metrics_listen_addr is empty) worker # [ 14.976840] dhcpcd[658]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 14.984906] dhcpcd[658]: eth0: adding route to 10.0.2.0/24 worker # [ 14.990827] dhcpcd[658]: eth0: adding default route via 10.0.2.2 worker # [ 15.011693] tailscaled[600]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/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::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/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::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/64] rebind-reason=[ips-changed] worker # [ 15.042420] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 15.044512] tailscaled[600]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 15.047111] tailscaled[600]: dns: OScfg: {} worker # [ 15.049176] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 15.051554] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 15.055114] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 15.058654] tailscaled[600]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 15.131524] systemd[1]: Started DHCP Client. worker # [ 15.135279] systemd[1]: Reached target Multi-User System. worker # [ 15.137235] systemd[1]: Startup finished in 1.002s (kernel) + 3.663s (initrd) + 10.470s (userspace) = 15.136s. hub # [ 18.361833] tailscaled[618]: wgengine: set DNS config again after major link change hub # [ 18.370457] tailscaled[618]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7ec8:b370:cda:5803/64] hub # [ 18.377679] tailscaled[618]: magicsock: 0 active derp conns hub # [ 18.388313] tailscaled[618]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 18.393209] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 18.395272] tailscaled[618]: router: portUpdate(port=41641, network=udp4) hub # [ 18.396926] tailscaled[618]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 18.819746] headscale-start[898]: 2026-07-15T12:19:12Z 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-SdR-5qGNJqOS-AlpyeSrFphWGSTp8q-Go56JJqIbn5cN3P7B3R_hrSt1HQHtKZrln4OqRg5AkB531 --hostname hub hub # [ 19.032700] tailscaled[618]: localapi: [POST] /localapi/v0/check-prefs hub # [ 19.036097] tailscaled[618]: localapi: [POST] /localapi/v0/start hub # [ 19.037859] tailscaled[618]: Start hub # [ 19.039788] 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 # [ 19.043875] tailscaled[618]: generating new machine key hub # [ 19.048793] tailscaled[618]: machine key written to store hub # [ 19.050585] tailscaled[618]: profile data directory: profile not found hub # [ 19.053846] tailscaled[618]: Backend: logs: be:7229bc3320a5f249e6317f8c5249d1857aafdceeabed476a23f3f758f4d03463 fe: hub # [ 19.056793] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 19.059662] tailscaled[618]: blockEngineUpdates(true) hub # [ 19.060952] tailscaled[618]: Reconfig(down): no changes made to Engine config hub # [ 19.069475] tailscaled[618]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 19.071707] tailscaled[618]: control: client.Shutdown ... hub # [ 19.073079] tailscaled[618]: control: mapRoutine: exiting hub # [ 19.074427] tailscaled[618]: health(warnable=wantrunning-false): ok hub # [ 19.076174] tailscaled[618]: control: authRoutine: exiting hub # [ 19.077845] tailscaled[618]: control: updateRoutine: exiting hub # [ 19.079801] tailscaled[618]: control: Client.Shutdown done. hub # [ 19.081578] tailscaled[618]: localapi: [POST] /localapi/v0/login-interactive hub # [ 19.084654] tailscaled[618]: StartLoginInteractiveAs("root"): url=false hub # [ 19.086262] tailscaled[618]: control: client.Login(2) hub # [ 19.088748] tailscaled[618]: control: LoginInteractive -> regen=true hub # [ 19.090450] tailscaled[618]: control: doLogin(regen=true, hasUrl=false) hub # [ 19.153449] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 19.169422] headscale-start[898]: 2026-07-15T12:19:12Z INF http request bytes=176 elapsed=3.432838 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:34336 status=200 hub # [ 19.176476] tailscaled[618]: control: control server key from https://hub: ts2021=[fHF4z], legacy= hub # [ 19.179415] tailscaled[618]: control: Generating a new nodekey. hub # [ 19.184043] tailscaled[618]: control: RegisterReq: onode= node=[iAKhC] fup=false nks=false worker # [ 16.109504] tailscaled[600]: wgengine: set DNS config again after major link change worker # [ 16.117824] tailscaled[600]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::d69c:9192:2567:ea4c/64] worker # [ 16.126541] tailscaled[600]: magicsock: 0 active derp conns worker # [ 16.138828] tailscaled[600]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 16.144493] tailscaled[600]: router: portUpdate(port=41641, network=udp6) worker # [ 16.149192] tailscaled[600]: router: portUpdate(port=41641, network=udp4) worker # [ 16.152832] tailscaled[600]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 19.922467] headscale-start[898]: 2026-07-15T12:19:13Z INF http request bytes=249 elapsed=715.232243 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:34342 status=200 hub # [ 19.934348] tailscaled[618]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 19.946173] tailscaled[618]: blockEngineUpdates(false) hub # [ 20.422461] headscale-start[898]: 2026-07-15T12:19:13Z INF http request bytes=0 elapsed=464.554294 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34342 status=200 hub # [ 20.925282] headscale-start[898]: 2026-07-15T12:19:14Z INF node connected machine.key=[OFKsJ] node.expired=false node.id=1 node.is_tagged=false node.key=[iAKhC] node.name=hub node.online=true user.name=test hub # [ 20.945816] headscale-start[898]: 2026-07-15T12:19:14Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x1c2f55a80a80 component=poll machine.key=[OFKsJ] node.expired=false node.id=1 node.is_tagged=false node.key=[iAKhC] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 20.997671] tailscaled[618]: health(warnable=not-in-map-poll): ok hub # [ 21.008947] tailscaled[618]: active login: test hub # [ 21.017207] tailscaled[618]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 21.022105] tailscaled[618]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 21.026730] tailscaled[618]: magicsock: SetPrivateKey called (init) hub # [ 21.028890] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers) hub # [ 21.031078] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 21.267541] tailscaled[618]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [19ms] (forced=false) hub # [ 21.270582] tailscaled[618]: magicsock: home is now derp-999 () hub # [ 21.273104] 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::7ec8:b370:cda:5803]:41641 (local) hub # [ 21.278588] tailscaled[618]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 21.281354] tailscaled[618]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 21.284092] tailscaled[618]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 21.292352] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 21.306433] tailscaled[618]: magicsock: derp-999 connected; connGen=1 hub # [ 21.572254] tailscaled[618]: router: enabling connmark-based rp_filter workaround hub # [ 21.679200] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 21.681644] tailscaled[618]: tsdial: bart table size: 2 hub # [ 21.683163] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 21.684973] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1} hub # [ 21.738100] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa} hub # [ 21.740413] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 21.823498] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 21.825272] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 21.828949] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 21.831658] systemd[1]: Stopping User and Group Name Lookups... hub # [ 21.834545] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 21.836267] systemd[1]: nscd.service: Deactivated successfully. hub # [ 21.838279] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 21.852258] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 21.885104] tailscaled[618]: peerapi: serving on http://100.64.0.1:58436 hub # [ 21.888480] tailscaled[618]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 21.893339] tailscaled[618]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 21.896893] tailscaled[618]: netmap: suggested exit node: () hub # [ 21.905350] tailscaled[618]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 21.909810] tailscaled[618]: writing netmap to disk cache hub # [ 21.912581] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 21.914199] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 21.918281] nsncd[1043]: Jul 15 12:19:15.181 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 21.924187] systemd[1]: Reached target User and Group Name Lookups. hub # [ 21.926578] headscale-start[898]: 2026-07-15T12:19:15Z INF http request bytes=0 elapsed=20.526073 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34342 status=200 hub # [ 21.934369] tailscaled[618]: health(warnable=no-derp-connection): ok hub # [ 21.936335] tailscaled[618]: health(warnable=no-derp-connection): ok hub # [ 21.940776] tailscaled[618]: health(warnable=warming-up): ok hub # [ 21.942257] tailscaled[618]: [RATELIMIT] format("health(warnable=%s): ok") hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-SdR-5qGNJqOS-AlpyeSrFphWGSTp8q-Go56JJqIbn5cN3P7B3R_hrSt1HQHtKZrln4OqRg5AkB531 --hostname hub, in 2.97 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-SdR-5qGNJqOS-AlpyeSrFphWGSTp8q-Go56JJqIbn5cN3P7B3R_hrSt1HQHtKZrln4OqRg5AkB531 --hostname tt-worker worker # [ 18.795374] tailscaled[600]: localapi: [POST] /localapi/v0/check-prefs worker # [ 18.798422] tailscaled[600]: localapi: [POST] /localapi/v0/start worker # [ 18.801639] tailscaled[600]: Start worker # [ 18.804339] tailscaled[600]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="tt-worker" update=check Persist=nil}, reason: [opts.UpdatePrefs] worker # [ 18.813188] tailscaled[600]: generating new machine key worker # [ 18.821874] tailscaled[600]: machine key written to store worker # [ 18.826226] tailscaled[600]: profile data directory: profile not found worker # [ 18.829557] tailscaled[600]: Backend: logs: be:498562d5a1ec2e4d78ce08b2a5818a54a31a8bf209fad875b4cc0907f263cc70 fe: worker # [ 18.834913] tailscaled[600]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 18.837362] tailscaled[600]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 18.840045] tailscaled[600]: blockEngineUpdates(true) worker # [ 18.842361] tailscaled[600]: Reconfig(down): no changes made to Engine config worker # [ 18.844837] tailscaled[600]: control: client.Shutdown ... worker # [ 18.846255] tailscaled[600]: control: mapRoutine: exiting worker # [ 18.847628] tailscaled[600]: health(warnable=wantrunning-false): ok worker # [ 18.850402] tailscaled[600]: localapi: [POST] /localapi/v0/login-interactive worker # [ 18.852121] tailscaled[600]: StartLoginInteractiveAs("root"): url=false worker # [ 18.853868] tailscaled[600]: control: client.Login(2) worker # [ 18.856502] tailscaled[600]: control: LoginInteractive -> regen=true worker # [ 18.858365] tailscaled[600]: control: doLogin(regen=true, hasUrl=false) worker # [ 18.860603] tailscaled[600]: control: authRoutine: exiting worker # [ 18.862304] tailscaled[600]: control: updateRoutine: exiting worker # [ 18.864203] tailscaled[600]: control: Client.Shutdown done. worker # [ 18.890304] tailscaled[600]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 22.105463] headscale-start[898]: 2026-07-15T12:19:15Z INF http request bytes=176 elapsed=0.215111 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:34358 status=200 worker # [ 18.906929] tailscaled[600]: control: control server key from https://hub: ts2021=[fHF4z], legacy= worker # [ 18.909608] tailscaled[600]: control: Generating a new nodekey. worker # [ 18.913880] tailscaled[600]: control: RegisterReq: onode= node=[+WGE+] fup=false nks=false hub # [ 22.429840] headscale-start[898]: 2026-07-15T12:19:15Z INF http request bytes=0 elapsed=496.050755 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34342 status=200 hub # [ 22.703916] tailscaled[618]: netmap: suggested exit node: () hub # [ 22.714236] tailscaled[618]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 22.720788] tailscaled[618]: netmap: suggested exit node: () worker # [ 19.723601] tailscaled[600]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 22.930462] headscale-start[898]: 2026-07-15T12:19:16Z INF http request bytes=249 elapsed=781.960836 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:34368 status=200 worker # [ 19.740111] tailscaled[600]: blockEngineUpdates(false) hub # [ 23.431930] headscale-start[898]: 2026-07-15T12:19:16Z INF http request bytes=0 elapsed=483.898093 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34368 status=200 hub # [ 23.510205] tailscaled[618]: netmap: suggested exit node: () hub # [ 23.515323] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) hub # [ 23.524604] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 23.529815] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 23.534479] tailscaled[618]: tsdial: bart table size: 4 hub # [ 23.537341] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 23.541471] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} hub # [ 23.613530] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} hub # [ 23.616484] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 23.671889] tailscaled[618]: netmap: suggested exit node: () hub # [ 23.673813] tailscaled[618]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)") hub # [ 23.775777] tailscaled[618]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 23.932836] headscale-start[898]: 2026-07-15T12:19:17Z INF node connected machine.key=[G3URb] node.expired=false node.id=2 node.is_tagged=false node.key=[+WGE+] node.name=tt-worker node.online=true user.name=test hub # [ 23.947403] headscale-start[898]: 2026-07-15T12:19:17Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x1c2f55a49ce0 component=poll machine.key=[G3URb] node.expired=false node.id=2 node.is_tagged=false node.key=[+WGE+] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test hub # [ 23.964603] headscale-start[898]: 2026-07-15T12:19:17Z INF http request bytes=0 elapsed=177.364162 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34342 status=200 worker # [ 20.787699] tailscaled[600]: health(warnable=not-in-map-poll): ok worker # [ 20.807590] tailscaled[600]: active login: test worker # [ 20.829211] tailscaled[600]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 20.834333] tailscaled[600]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 20.840688] tailscaled[600]: magicsock: SetPrivateKey called (init) worker # [ 20.845643] tailscaled[600]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) worker # [ 20.848165] tailscaled[600]: wgengine: Reconfig: configuring router worker # [ 20.967406] tailscaled[600]: router: enabling connmark-based rp_filter workaround worker # [ 20.991119] tailscaled[600]: wgengine: Reconfig: user dialer worker # [ 20.992892] tailscaled[600]: tsdial: bart table size: 4 worker # [ 20.994562] tailscaled[600]: wgengine: Reconfig: configuring DNS worker # [ 20.996485] tailscaled[600]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} worker # [ 21.013747] tailscaled[600]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} worker # [ 21.016396] tailscaled[600]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 21.058398] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 21.060907] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 21.064643] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 21.066308] systemd[1]: Stopping User and Group Name Lookups... worker # [ 21.067860] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 21.070628] systemd[1]: nscd.service: Deactivated successfully. worker # [ 21.072828] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 21.075261] tailscaled[600]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [1ms] (forced=false) worker # [ 21.080061] tailscaled[600]: magicsock: home is now derp-999 () worker # [ 21.086225] tailscaled[600]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::d69c:9192:2567:ea4c]:41641 (local) worker # [ 21.095898] tailscaled[600]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 21.098518] tailscaled[600]: magicsock: 1 active derp conns: derp-999=cr0s,wr2ms worker # [ 21.102081] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 21.104687] tailscaled[600]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 21.116119] tailscaled[600]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 21.129122] tailscaled[600]: peerapi: serving on http://100.64.0.2:46590 worker # [ 21.130889] tailscaled[600]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 21.135109] tailscaled[600]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 21.142859] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 21.146449] nsncd[925]: Jul 15 12:19:18.324 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 21.151236] tailscaled[600]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 21.155128] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 21.156822] systemd[1]: Reached target User and Group Name Lookups. worker # [ 21.161483] tailscaled[600]: magicsock: derp-999 connected; connGen=1 worker # [ 21.164245] tailscaled[600]: netmap: suggested exit node: () worker # [ 21.166566] tailscaled[600]: writing netmap to disk cache worker # [ 21.171910] tailscaled[600]: health(warnable=no-derp-connection): ok worker # [ 21.173996] tailscaled[600]: health(warnable=no-derp-connection): ok worker # [ 21.176460] tailscaled[600]: health(warnable=warming-up): ok worker # [ 21.177958] tailscaled[600]: [RATELIMIT] format("health(warnable=%s): ok") worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-SdR-5qGNJqOS-AlpyeSrFphWGSTp8q-Go56JJqIbn5cN3P7B3R_hrSt1HQHtKZrln4OqRg5AkB531 --hostname tt-worker, in 2.44 seconds) worker: waiting for success: tailscale ping hub worker # [ 21.207322] tailscaled[600]: localapi: [POST] /localapi/v0/ping worker # [ 21.209352] tailscaled[600]: ping(100.64.0.1): sending disco ping to [iAKhC] hub ... worker # [ 21.219111] tailscaled[600]: magicsock: disco: node [iAKhC] d:dc6a5c90ce4c5b39 now using 192.168.1.1:41641 mtu=1360 tx=9ea040428f12 worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds) hub: must succeed: tailscale ip -4 hub # [ 24.438309] headscale-start[898]: 2026-07-15T12:19:17Z INF http request bytes=0 elapsed=88.794246 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34368 status=200 hub: (finished: must succeed: tailscale ip -4, in 0.08 seconds) worker: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml worker: (finished: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml, in 0.04 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 24.590180] systemd[1]: Starting tribuchet-hub.socket... hub # [ 24.600233] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 24.605519] systemd[1]: Starting tribuchet-hub.service... worker # [ 21.407342] tailscaled[600]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 24.691719] tribuchet[1086]: 2026-07-15T12:19:17.954315Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 24.696770] tribuchet[1086]: 2026-07-15T12:19:17.956438Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers hub # [ 24.701794] tribuchet[1086]: 2026-07-15T12:19:17.966654Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 24.710584] tribuchet[1086]: 2026-07-15T12:19:17.975493Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 24.715181] systemd[1]: Started tribuchet-hub.service. hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.17 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 21.574580] systemd[1]: Starting tribuchet-worker.service... worker # [ 21.659883] exec[966]: 2026-07-15T12:19:18.841714Z 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 # [ 21.675347] exec[969]: 2026-07-15T12:19:18.856939Z 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 # [ 21.690567] exec[969]: 2026-07-15T12:19:18.872725Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 21.698261] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.19 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' hub # [ 24.946455] headscale-start[898]: 2026-07-15T12:19:18Z INF http request bytes=0 elapsed=487.909776 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34368 status=200 hub # [ 24.958906] tailscaled[618]: magicsock: disco: node [+WGE+] d:ff22ef8434c7b016 now using [2001:db8:1::2]:41641 mtu=1360 tx=23083a6ac1cd hub # [ 24.969743] tailscaled[618]: magicsock: disco: node [+WGE+] d:ff22ef8434c7b016 now using 192.168.1.2:41641 mtu=1360 tx=488bc62b74c3 hub # [ 25.016340] tribuchet[1086]: 2026-07-15T12:19:18.281326Z 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.12 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 # [ 21.842246] exec[969]: 2026-07-15T12:19:19.023967Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] worker # [ 21.893768] tailscaled[600]: netmap: suggested exit node: () worker # [ 21.903435] tailscaled[600]: [RATELIMIT] format("control: [v\x00JSON]%d%s") worker # [ 21.911182] tailscaled[600]: 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 # [ 25.438199] headscale-start[898]: 2026-07-15T12:19:18Z INF http request bytes=0 elapsed=468.254764 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34368 status=200 hub # building '/nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv'... hub # [ 25.512178] tribuchet[1086]: 2026-07-15T12:19:18.777289Z INFO tribuchet::hub::submit: queueing build id="5a1bf61f4f1e7383a2cb20e6a9307699" system="x86_64-linux" hub # [ 25.517582] tribuchet[1086]: 2026-07-15T12:19:18.782717Z INFO tribuchet::hub: dispatching build id="5a1bf61f4f1e7383a2cb20e6a9307699" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 22.319517] exec[969]: 2026-07-15T12:19:19.499551Z INFO tribuchet::worker: build assigned id="5a1bf61f4f1e7383a2cb20e6a9307699" worker # [ 22.335954] systemd[1]: Started Nix Daemon. worker # [ 22.400336] nix-daemon[971]: accepted connection from pid 969, user tribuchet (trusted) hub # [ 25.617570] tribuchet[1086]: 2026-07-15T12:19:18.882538Z INFO tribuchet::hub::relay: input path negotiation done id="5a1bf61f4f1e7383a2cb20e6a9307699" total=8 missing=1 hub # [ 25.636424] systemd[1]: Started Nix Daemon. hub # [ 25.761108] nix-daemon[1115]: accepted connection from pid 1086, user root (trusted) worker # [ 22.624376] exec[969]: 2026-07-15T12:19:19.806128Z INFO tribuchet::worker::build: sandbox network decision id="5a1bf61f4f1e7383a2cb20e6a9307699" fixed_output=false network=false net_isolation=false worker # [ 22.653174] systemd[1]: Starting tribuchet-sandboxd.service... worker # [ 22.687807] tailscaled[600]: netmap: suggested exit node: () worker # [ 22.696338] tribuchet-sandboxd[979]: 2026-07-15T12:19:19.878066Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock worker # [ 22.701300] systemd[1]: Started tribuchet-sandboxd.service. worker # [ 22.705315] exec[969]: 2026-07-15T12:19:19.886587Z INFO tribuchet::worker::build: leased sandbox build_id="5a1bf61f4f1e7383a2cb20e6a9307699" pool_base=1325400064 uid_count=1 worker # [ 22.710364] tribuchet-sandboxd[979]: 2026-07-15T12:19:19.892384Z INFO tribuchet_sandboxd: leased build="5a1bf61f4f1e7383a2cb20e6a9307699" base=1325400064 uid_count=1 worker # [ 22.911607] tribuchet-sandboxd[979]: 2026-07-15T12:19:20.093469Z INFO tribuchet_sandboxd: released build="5a1bf61f4f1e7383a2cb20e6a9307699" base=1325400064 worker # [ 22.922974] exec[969]: 2026-07-15T12:19:20.105055Z INFO tribuchet::worker::build: builder finished id="5a1bf61f4f1e7383a2cb20e6a9307699" exit_code=0 worker # [ 22.951241] exec[969]: 2026-07-15T12:19:20.133039Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="5a1bf61f4f1e7383a2cb20e6a9307699" worker # [ 22.975785] exec[969]: 2026-07-15T12:19:20.157884Z INFO tribuchet::worker::resume: build result acknowledged id="5a1bf61f4f1e7383a2cb20e6a9307699" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 1.00 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.28 seconds) subtest: a non-tailnet peer is rejected worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.02 seconds) worker: must succeed: systemctl restart tribuchet-worker worker # [ 23.145114] exec[969]: 2026-07-15T12:19:20.324231Z INFO tribuchet::worker: handover requested; exiting worker # [ 23.148306] systemd[1]: Stopping tribuchet-worker.service... hub # [ 26.355252] tribuchet[1086]: 2026-07-15T12:19:19.619900Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 23.353162] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 23.360241] systemd[1]: Stopped tribuchet-worker.service. worker # [ 23.365123] systemd[1]: tribuchet-worker.service: Consumed 95ms CPU time over 1.781s wall clock time, 18M memory peak, 14.2M read from disk, 4K written to disk, 3.8K incoming IP traffic, 2K outgoing IP traffic. worker # [ 23.391499] systemd[1]: Starting tribuchet-worker.service... worker # [ 23.446706] exec[1003]: 2026-07-15T12:19:20.628628Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false } worker # [ 23.463264] exec[1006]: 2026-07-15T12:19:20.643167Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false } worker # [ 23.475615] exec[1006]: 2026-07-15T12:19:20.643730Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 23.481661] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.36 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' hub # [ 27.068957] tribuchet[1086]: 2026-07-15T12:19:20.333626Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:53964 worker # [ 23.873464] exec[1006]: 2026-07-15T12:19:21.055395Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 23.885410] exec[1006]: 2026-07-15T12:19:21.055487Z INFO tribuchet::worker: reconnecting to hub in 1s hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.15 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.53 seconds) (finished: run the VM test script, in 29.01 seconds) test script finished in 29.09s 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.35 seconds) additionally exposed symbols: hub, worker, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh