nixbot

builds

succeeded vm-test-run-tribuchet-tailscale default.checks.x86_64-linux.nixos-test-tailscale · build #176 · raw

1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7start all VMs8hub: starting vm9worker: starting vm10hub: QEMU running (pid 47)11hub # Disk image does not exist, creating the virtualisation disk image...12hub # Formatting '/build/vm-state-hub/tmp.pW907Jt1RJ', fmt=raw size=107374182413hub # mke2fs 1.47.4 (6-Mar-2025)14hub # Discarding device blocks: 0/262144 done15hub # Creating filesystem with 262144 4k blocks and 65536 inodes16hub # Filesystem UUID: f9da0205-1485-41c9-b505-138371d9e86c17hub # Superblock backups stored on blocks:18hub # 32768, 98304, 163840, 22937619hub # 20hub # Allocating group tables: 0/8 done21hub # Writing inode tables: 0/8 done22hub # Creating journal (8192 blocks): done23hub # Writing superblocks and filesystem accounting information: 0/8 done24hub # 25hub # Virtualisation disk image created.26hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)27hub # 28hub # 29hub # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1920+7EF31920 CA0030hub # Press Ctrl-B to configure iPXE (PCI 00:03.0)...31hub # 32hub # 33hub # 34hub # 35hub # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1920 7EF31920 CB0036hub # Press Ctrl-B to configure iPXE (PCI 00:09.0)...37hub # 38hub # 39hub # Booting from ROM...40hub # Probing EDD (edd=off to disable)... ok41hub # [ 0.000000] Linux version 6.18.39 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 18 14:53:38 UTC 202642hub # [ 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/ms9d16vahzlwa4jllfys4vsqjr45p7ff-nixos-system-hub-test/init regInfo=/nix/store/jcwry8gg0ysdwba0z40b5cc54k04q1ii-closure-info/registration console=ttyS0,115200n8 console=tty043hub # [ 0.000000] BIOS-provided physical RAM map:44hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable45hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved46hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved47hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable48hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved49hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved50hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved51hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved52hub # [ 0.000000] NX (Execute Disable) protection: active53hub # [ 0.000000] APIC: Static calls initialized54hub # [ 0.000000] SMBIOS 2.8 present.55hub # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201456hub # [ 0.000000] DMI: Memory slots populated: 1/157hub # [ 0.000000] Hypervisor detected: KVM58hub # [ 0.000000] last_pfn = 0x7ffdb max_arch_pfn = 0x1000000000059hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0060hub # [ 0.000000] kvm-clock: using sched offset of 499275640 cycles61hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns62hub # [ 0.000004] tsc: Detected 2400.010 MHz processor63hub # [ 0.000813] last_pfn = 0x7ffdb max_arch_pfn = 0x1000000000064hub # [ 0.000852] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs65hub # [ 0.000855] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT66hub # [ 0.002795] found SMP MP-table at [mem 0x000f5470-0x000f547f]67hub # [ 0.002807] Using GB pages for direct mapping68hub # [ 0.002930] RAMDISK: [mem 0x7e3ad000-0x7ffcffff]69hub # [ 0.002937] ACPI: Early table checksum verification disabled70hub # [ 0.002939] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )71hub # [ 0.002943] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)72hub # [ 0.002947] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)73hub # [ 0.002954] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)74hub # [ 0.002956] ACPI: FACS 0x000000007FFE0000 00004075hub # [ 0.002957] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)76hub # [ 0.002959] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)77hub # [ 0.002961] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)78hub # [ 0.002962] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]79hub # [ 0.002963] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]80hub # [ 0.002964] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]81hub # [ 0.002964] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]82hub # [ 0.002965] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]83hub # [ 0.002965] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]84hub # [ 0.003459] No NUMA configuration found85hub # [ 0.003460] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff]86hub # [ 0.003463] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff]87hub # [ 0.005893] Zone ranges:88hub # [ 0.005893] DMA [mem 0x0000000000001000-0x0000000000ffffff]89hub # [ 0.005895] DMA32 [mem 0x0000000001000000-0x000000007ffdafff]90hub # [ 0.005897] Normal empty91hub # [ 0.005897] Device empty92hub # [ 0.005898] Movable zone start for each node93hub # [ 0.005899] Early memory node ranges94hub # [ 0.005899] node 0: [mem 0x0000000000001000-0x000000000009efff]95hub # [ 0.005900] node 0: [mem 0x0000000000100000-0x000000007ffdafff]96hub # [ 0.005901] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff]97hub # [ 0.005922] On node 0, zone DMA: 1 pages in unavailable ranges98hub # [ 0.006216] On node 0, zone DMA: 97 pages in unavailable ranges99hub # [ 0.043682] On node 0, zone DMA32: 37 pages in unavailable ranges100hub # [ 0.044692] ACPI: PM-Timer IO Port: 0x608101hub # [ 0.044708] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])102hub # [ 0.044742] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23103hub # [ 0.044745] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)104hub # [ 0.044747] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)105hub # [ 0.044748] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)106hub # [ 0.044749] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)107hub # [ 0.044750] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)108hub # [ 0.044752] ACPI: Using ACPI (MADT) for SMP configuration information109hub # [ 0.044753] ACPI: HPET id: 0x8086a201 base: 0xfed00000110hub # [ 0.044759] TSC deadline timer available111hub # [ 0.044763] CPU topo: Max. logical packages: 1112hub # [ 0.044764] CPU topo: Max. logical dies: 1113hub # [ 0.044764] CPU topo: Max. dies per package: 1114hub # [ 0.044767] CPU topo: Max. threads per core: 1115hub # [ 0.044768] CPU topo: Num. cores per package: 1116hub # [ 0.044768] CPU topo: Num. threads per package: 1117hub # [ 0.044769] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs118hub # [ 0.044791] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()119hub # [ 0.044832] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]120hub # [ 0.044833] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]121hub # [ 0.044834] [mem 0x80000000-0xfeffbfff] available for PCI devices122hub # [ 0.044836] Booting paravirtualized kernel on KVM123hub # [ 0.044839] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns124hub # [ 0.049300] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1125hub # [ 0.051563] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152126hub # [ 0.051612] kvm-guest: PV spinlocks disabled, single CPU127hub # [ 0.051613] 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/ms9d16vahzlwa4jllfys4vsqjr45p7ff-nixos-system-hub-test/init regInfo=/nix/store/jcwry8gg0ysdwba0z40b5cc54k04q1ii-closure-info/registration console=ttyS0,115200n8 console=tty0128hub # [ 0.051704] Unknown kernel command line parameters "regInfo=/nix/store/jcwry8gg0ysdwba0z40b5cc54k04q1ii-closure-info/registration", will be passed to user space.129hub # [ 0.051717] random: crng init done130hub # [ 0.051717] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes131hub # [ 0.053977] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)132hub # [ 0.055295] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)133hub # [ 0.055329] Fallback order for Node 0: 0134hub # [ 0.055332] Built 1 zonelists, mobility grouping on. Total pages: 524153135hub # [ 0.055333] Policy zone: DMA32136hub # [ 0.057858] mem auto-init: stack:all(zero), heap alloc:on, heap free:off137hub # [ 0.061529] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1138hub # [ 0.066095] allocated 4194304 bytes of page_ext139hub # [ 0.075812] ftrace: allocating 48593 entries in 192 pages140hub # [ 0.075815] ftrace: allocated 192 pages with 2 groups141hub # [ 0.076850] Dynamic Preempt: lazy142hub # [ 0.077019] rcu: Preemptible hierarchical RCU implementation.143hub # [ 0.077020] rcu: RCU event tracing is enabled.144hub # [ 0.077021] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.145hub # [ 0.077022] Trampoline variant of Tasks RCU enabled.146hub # [ 0.077023] Rude variant of Tasks RCU enabled.147hub # [ 0.077023] Tracing variant of Tasks RCU enabled.148hub # [ 0.077024] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.149hub # [ 0.077025] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1150hub # [ 0.077046] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.151hub # [ 0.077047] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.152hub # [ 0.077048] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.153hub # [ 0.081374] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16154hub # [ 0.081633] rcu: srcu_init: Setting srcu_struct sizes based on contention.155hub # [ 0.081641] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns156hub # [ 0.081742] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)157hub # [ 0.088980] Console: colour VGA+ 80x25158hub # [ 0.088983] printk: legacy console [tty0] enabled159hub # [ 0.130425] printk: legacy console [ttyS0] enabled160hub # [ 0.320452] ACPI: Core revision 20250807161hub # [ 0.322070] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns162hub # [ 0.324939] APIC: Switch to symmetric I/O mode setup163hub # [ 0.326707] x2apic enabled164hub # [ 0.327964] APIC: Switched APIC routing to: physical x2apic165hub # [ 0.330813] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1166hub # [ 0.332643] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns167hub # [ 0.335761] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)168hub # [ 0.337875] x86/cpu: User Mode Instruction Prevention (UMIP) activated169hub # [ 0.338909] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127170hub # [ 0.339756] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0171hub # [ 0.340760] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto172hub # [ 0.341756] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl173hub # [ 0.343756] Transient Scheduler Attacks: Mitigation: Clear CPU buffers174hub # [ 0.344755] Spectre V2 : Mitigation: Enhanced / Automatic IBRS175hub # [ 0.345756] Speculative Return Stack Overflow: Mitigation: Safe RET176hub # [ 0.346756] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization177hub # [ 0.347766] Spectre V2 : Enabling IBPB for BPF178hub # [ 0.348758] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier179hub # [ 0.349757] active return thunk: srso_alias_return_thunk180hub # [ 0.351793] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'181hub # [ 0.353755] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'182hub # [ 0.355755] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'183hub # [ 0.357755] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'184hub # [ 0.359756] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'185hub # [ 0.360756] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'186hub # [ 0.361755] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'187hub # [ 0.363756] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'188hub # [ 0.364756] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'189hub # [ 0.366756] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256190hub # [ 0.367756] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64191hub # [ 0.369756] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512192hub # [ 0.371756] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024193hub # [ 0.373756] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8194hub # [ 0.374756] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16195hub # [ 0.376756] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24196hub # [ 0.377756] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.197hub # [ 0.412951] Freeing SMP alternatives memory: 44K198hub # [ 0.413758] pid_max: default: 32768 minimum: 301199hub # [ 0.415853] LSM: initializing lsm=capability,landlock,yama,bpf,ima200hub # [ 0.416875] landlock: Up and running.201hub # [ 0.417755] Yama: becoming mindful.202hub # [ 0.419781] LSM support for eBPF active203hub # [ 0.420901] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)204hub # [ 0.422800] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)205hub # [ 0.426917] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)206hub # [ 0.428476] Performance Events: Fam17h+ core perfctr, AMD PMU driver.207hub # [ 0.429766] ... version: 2208hub # [ 0.430757] ... bit width: 48209hub # [ 0.431757] ... generic counters: 6210hub # [ 0.432757] ... generic bitmap: 000000000000003f211hub # [ 0.433757] ... fixed-purpose counters: 0212hub # [ 0.434757] ... fixed-purpose bitmap: 0000000000000000213hub # [ 0.435757] ... value mask: 0000ffffffffffff214hub # [ 0.436757] ... max period: 00007fffffffffff215hub # [ 0.437757] ... global_ctrl mask: 000000000000003f216hub # [ 0.438860] signal: max sigframe size: 3376217hub # [ 0.439908] rcu: Hierarchical SRCU implementation.218hub # [ 0.440762] rcu: Max phase no-delay instances is 400.219hub # [ 0.446349] smp: Bringing up secondary CPUs ...220hub # [ 0.446774] smp: Brought up 1 node, 1 CPU221hub # [ 0.447760] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)222hub # [ 0.448927] Memory: 1969956K/2096612K available (17150K kernel code, 2721K rwdata, 13544K rodata, 3640K init, 3012K bss, 117256K reserved, 0K cma-reserved)223hub # [ 0.449997] devtmpfs: initialized224hub # [ 0.451036] x86/mm: Memory block size: 128MB225hub # [ 0.452883] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)226hub # [ 0.453793] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).227hub # [ 0.454841] pinctrl core: initialized pinctrl subsystem228hub # [ 0.456074] PM: RTC time: 11:07:33, date: 2026-08-01229hub # [ 0.459506] NET: Registered PF_NETLINK/PF_ROUTE protocol family230hub # [ 0.461250] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations231hub # [ 0.461784] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations232hub # [ 0.463050] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations233hub # [ 0.463770] audit: initializing netlink subsys (disabled)234hub # [ 0.465031] thermal_sys: Registered thermal governor 'fair_share'235hub # [ 0.465033] thermal_sys: Registered thermal governor 'bang_bang'236hub # [ 0.465761] audit: type=2000 audit(1785582453.050:1): state=initialized audit_enabled=0 res=1237hub # [ 0.467760] thermal_sys: Registered thermal governor 'step_wise'238hub # [ 0.467763] thermal_sys: Registered thermal governor 'user_space'239hub # [ 0.468757] thermal_sys: Registered thermal governor 'power_allocator'240hub # [ 0.469780] cpuidle: using governor menu241hub # [ 0.472962] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5242hub # [ 0.474047] PCI: Using configuration type 1 for base access243hub # [ 0.474757] PCI: Using configuration type 1 for extended access244hub # [ 0.476004] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.245hub # [ 0.481018] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages246hub # [ 0.481758] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page247hub # [ 0.486757] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages248hub # [ 0.487758] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page249hub # [ 0.498108] ACPI: Added _OSI(Module Device)250hub # [ 0.498758] ACPI: Added _OSI(Processor Device)251hub # [ 0.503757] ACPI: Added _OSI(Processor Aggregator Device)252hub # [ 0.508623] ACPI: 1 ACPI AML tables successfully acquired and loaded253hub # [ 0.512635] ACPI: Interpreter enabled254hub # [ 0.513674] ACPI: PM: (supports S0 S3 S4 S5)255hub # [ 0.516757] ACPI: Using IOAPIC for interrupt routing256hub # [ 0.517805] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug257hub # [ 0.520757] PCI: Using E820 reservations for host bridge windows258hub # [ 0.521907] ACPI: Enabled 2 GPEs in block 00 to 0F259hub # [ 0.530099] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])260hub # [ 0.530764] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]261hub # [ 0.532159] acpiphp: Slot [3] registered262hub # [ 0.532798] acpiphp: Slot [4] registered263hub # [ 0.533817] acpiphp: Slot [5] registered264hub # [ 0.534800] acpiphp: Slot [6] registered265hub # [ 0.535797] acpiphp: Slot [7] registered266hub # [ 0.536797] acpiphp: Slot [8] registered267hub # [ 0.537811] acpiphp: Slot [9] registered268hub # [ 0.538799] acpiphp: Slot [10] registered269hub # [ 0.539799] acpiphp: Slot [11] registered270hub # [ 0.540831] acpiphp: Slot [12] registered271hub # [ 0.541798] acpiphp: Slot [13] registered272hub # [ 0.542789] acpiphp: Slot [14] registered273hub # [ 0.543790] acpiphp: Slot [15] registered274hub # [ 0.544804] acpiphp: Slot [16] registered275hub # [ 0.545791] acpiphp: Slot [17] registered276hub # [ 0.546790] acpiphp: Slot [18] registered277hub # [ 0.547789] acpiphp: Slot [19] registered278hub # [ 0.548805] acpiphp: Slot [20] registered279hub # [ 0.549790] acpiphp: Slot [21] registered280hub # [ 0.550804] acpiphp: Slot [22] registered281hub # [ 0.551789] acpiphp: Slot [23] registered282hub # [ 0.552807] acpiphp: Slot [24] registered283hub # [ 0.553791] acpiphp: Slot [25] registered284hub # [ 0.554790] acpiphp: Slot [26] registered285hub # [ 0.555811] acpiphp: Slot [27] registered286hub # [ 0.556792] acpiphp: Slot [28] registered287hub # [ 0.557812] acpiphp: Slot [29] registered288hub # [ 0.558791] acpiphp: Slot [30] registered289hub # [ 0.559805] acpiphp: Slot [31] registered290hub # [ 0.560780] PCI host bridge to bus 0000:00291hub # [ 0.561765] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]292hub # [ 0.562759] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]293hub # [ 0.563759] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]294hub # [ 0.564759] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]295hub # [ 0.565758] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]296hub # [ 0.566758] pci_bus 0000:00: root bus resource [bus 00-ff]297hub # [ 0.568077] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint298hub # [ 0.569667] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint299hub # [ 0.571668] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint300hub # [ 0.574508] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]301hub # [ 0.575832] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk302hub # [ 0.576758] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk303hub # [ 0.577758] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk304hub # [ 0.578758] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk305hub # [ 0.580122] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint306hub # [ 0.582319] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]307hub # [ 0.583986] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint308hub # [ 0.585387] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI309hub # [ 0.586772] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB310hub # [ 0.588167] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint311hub # [ 0.590846] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]312hub # [ 0.591786] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]313hub # [ 0.592811] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]314hub # [ 0.594030] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]315hub # [ 0.595910] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint316hub # [ 0.598785] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]317hub # [ 0.599773] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]318hub # [ 0.600811] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]319hub # [ 0.601772] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]320hub # [ 0.605410] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint321hub # [ 0.608793] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]322hub # [ 0.609773] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]323hub # [ 0.611264] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]324hub # [ 0.613797] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint325hub # [ 0.616844] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]326hub # [ 0.617773] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]327hub # [ 0.618811] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]328hub # [ 0.621811] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint329hub # [ 0.625793] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]330hub # [ 0.626773] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]331hub # [ 0.627810] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]332hub # [ 0.631170] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint333hub # [ 0.633827] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]334hub # [ 0.634772] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]335hub # [ 0.635811] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]336hub # [ 0.639012] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint337hub # [ 0.641772] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]338hub # [ 0.642772] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]339hub # [ 0.643811] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]340hub # [ 0.646810] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint341hub # [ 0.649321] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]342hub # [ 0.649773] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]343hub # [ 0.650811] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]344hub # [ 0.651773] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]345hub # [ 0.654786] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint346hub # [ 0.656815] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]347hub # [ 0.657811] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]348hub # [ 0.660797] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint349hub # [ 0.663773] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]350hub # [ 0.664773] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]351hub # [ 0.665811] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]352hub # [ 0.668857] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint353hub # [ 0.671663] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]354hub # [ 0.672772] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]355hub # [ 0.673811] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]356hub # [ 0.682317] ACPI: PCI: Interrupt link LNKA configured for IRQ 10357hub # [ 0.682973] ACPI: PCI: Interrupt link LNKB configured for IRQ 10358hub # [ 0.683948] ACPI: PCI: Interrupt link LNKC configured for IRQ 11359hub # [ 0.684958] ACPI: PCI: Interrupt link LNKD configured for IRQ 11360hub # [ 0.685868] ACPI: PCI: Interrupt link LNKS configured for IRQ 9361hub # [ 0.687992] iommu: Default domain type: Translated362hub # [ 0.688768] iommu: DMA domain TLB invalidation policy: lazy mode363hub # [ 0.690053] ACPI: bus type USB registered364hub # [ 0.690825] usbcore: registered new interface driver usbfs365hub # [ 0.691787] usbcore: registered new interface driver hub366hub # [ 0.692772] usbcore: registered new device driver usb367hub # [ 0.694739] NetLabel: Initializing368hub # [ 0.695602] NetLabel: domain hash size = 128369hub # [ 0.696757] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO370hub # [ 0.697818] NetLabel: unlabeled traffic allowed by default371hub # [ 0.698774] PCI: Using ACPI for IRQ routing372hub # [ 0.700462] pci 0000:00:02.0: vgaarb: setting as boot VGA device373hub # [ 0.700752] pci 0000:00:02.0: vgaarb: bridge control possible374hub # [ 0.700752] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none375hub # [ 0.700760] vgaarb: loaded376hub # [ 0.701925] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0377hub # [ 0.702758] hpet0: 3 comparators, 64-bit 100.000000 MHz counter378hub # [ 0.706856] clocksource: Switched to clocksource kvm-clock379hub # [ 0.710984] VFS: Disk quotas dquot_6.6.0380hub # [ 0.712265] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)381hub # [ 0.714526] pnp: PnP ACPI init382hub # [ 0.716258] pnp: PnP ACPI: found 6 devices383hub # [ 0.724498] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns384hub # [ 0.727093] clocksource: Switched to clocksource acpi_pm385hub # [ 0.728898] NET: Registered PF_INET protocol family386hub # [ 0.730787] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)387hub # [ 0.749315] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)388hub # [ 0.752018] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)389hub # [ 0.754382] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)390hub # [ 0.756747] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)391hub # [ 0.759020] TCP: Hash tables configured (established 16384 bind 16384)392hub # [ 0.761096] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)393hub # [ 0.763399] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)394hub # [ 0.765391] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)395hub # [ 0.767570] NET: Registered PF_UNIX/PF_LOCAL protocol family396hub # [ 0.769303] NET: Registered PF_XDP protocol family397hub # [ 0.770844] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]398hub # [ 0.772710] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]399hub # [ 0.774549] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]400hub # [ 0.776563] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]401hub # [ 0.778607] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]402hub # [ 0.780745] pci 0000:00:01.0: PIIX3: Enabling Passive Release403hub # [ 0.782511] pci 0000:00:00.0: Limiting direct PCI/PCI transfers404hub # [ 0.785833] ACPI: \_SB_.LNKD: Enabled at IRQ 11405hub # [ 0.789236] PCI: CLS 0 bytes, default 64406hub # [ 0.790734] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns407hub # [ 0.793773] Trying to unpack rootfs image as initramfs...408hub # [ 0.843894] Initialise system trusted keyrings409hub # [ 0.848346] workingset: timestamp_bits=40 max_order=19 bucket_order=0410hub # [ 0.874462] Key type asymmetric registered411hub # [ 0.875846] Asymmetric key parser 'x509' registered412hub # [ 0.879217] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)413hub # [ 0.886223] io scheduler mq-deadline registered414hub # [ 0.887659] io scheduler kyber registered415hub # [ 0.891757] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled416hub # [ 0.893997] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A417hub # [ 0.904312] Linux agpgart interface v0.103418hub # [ 0.905711] ACPI: bus type drm_connector registered419hub # [ 0.909676] usbcore: registered new interface driver usbserial_generic420hub # [ 0.911658] usbserial: USB Serial support registered for generic421hub # [ 0.918170] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.422hub # [ 0.918170] Please enable it if your BIOS has the CPPC option.423hub # [ 0.922213] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled424hub # [ 0.931299] drop_monitor: Initializing network drop monitor service425hub # [ 0.933341] NET: Registered PF_INET6 protocol family426hub # [ 0.937676] Segment Routing with IPv6427hub # [ 0.942190] In-situ OAM (IOAM) with IPv6428hub # [ 0.945488] IPI shorthand broadcast: enabled429hub # [ 0.954624] sched_clock: Marking stable (707029190, 247111782)->(1165370124, -211229152)430hub # [ 0.963424] registered taskstats version 1431hub # [ 0.965035] Loading compiled-in X.509 certificates432hub # [ 0.988175] Demotion targets for Node 0: null433hub # [ 0.992199] Key type .fscrypt registered434hub # [ 0.993478] Key type fscrypt-provisioning registered435hub # [ 0.997279] ima: No TPM chip found, activating TPM-bypass!436hub # [ 0.998990] ima: Allocated hash algorithm: sha1437hub # [ 1.004190] ima: No architecture policies found438hub # [ 1.007168] PM: Magic number: 6:317:124439hub # [ 1.011398] RAS: Correctable Errors collector initialized.440hub # [ 1.020903] clk: Disabling unused clocks441hub # [ 1.026177] PM: genpd: Disabling unused power domains442hub # [ 1.168071] Freeing initrd memory: 28812K443hub # [ 1.172044] Freeing unused decrypted memory: 2028K444hub # [ 1.175587] Freeing unused kernel image (initmem) memory: 3640K445hub # [ 1.177504] Write protecting the kernel read-only data: 32768k446hub # [ 1.180303] Freeing unused kernel image (text/rodata gap) memory: 1280K447hub # [ 1.182782] Freeing unused kernel image (rodata/data gap) memory: 792K448hub # [ 1.236031] x86/mm: Checked W+X mappings: passed, no W+X pages found.449hub # [ 1.238040] Run /init as init process450hub # [ 1.249462] systemd[1]: Inserted module 'autofs4'451hub # [ 1.266574] fuse: init (API version 7.45)452hub # [ 1.274094] ACPI: \_SB_.LNKC: Enabled at IRQ 10453hub # [ 1.282757] ACPI: \_SB_.LNKA: Enabled at IRQ 10454hub # [ 1.287359] ACPI: \_SB_.LNKB: Enabled at IRQ 11455hub # [ 1.327103] systemd[1]: Successfully made /usr/ read-only.456hub # [ 1.666529] 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)457hub # [ 1.689216] systemd[1]: Detected virtualization kvm.458hub # [ 1.693256] systemd[1]: Detected architecture x86-64.459hub # [ 1.697318] systemd[1]: Running in initrd.460hub # [ 1.701589] systemd[1]: Initializing machine ID from random generator.461hub # [ 1.707248] systemd[1]: Hostname set to <hub>.462hub # [ 1.930485] systemd[1]: bpf-restrict-fs: LSM BPF program attached463hub # [ 1.991623] systemd[1]: Queued start job for default target Initrd Default Target.464hub # [ 1.996811] systemd[1]: Created slice Slice /system/modprobe.465hub # [ 1.998927] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.466hub # [ 2.001518] systemd[1]: Expecting device /dev/disk/by-label/nixos...467hub # [ 2.003524] systemd[1]: Reached target Path Units.468hub # [ 2.005156] systemd[1]: Reached target Slice Units.469hub # [ 2.006767] systemd[1]: Reached target Swaps.470hub # [ 2.008239] systemd[1]: Reached target Timer Units.471hub # [ 2.010015] systemd[1]: Listening on D-Bus System Message Bus Socket.472hub # [ 2.012283] systemd[1]: Listening on Journal Socket (/dev/log).473hub # [ 2.014410] systemd[1]: Listening on Journal Sockets.474hub # [ 2.016249] systemd[1]: Listening on udev Control Socket.475hub # [ 2.018104] systemd[1]: Listening on udev Kernel Socket.476hub # [ 2.019896] systemd[1]: Reached target Socket Units.477hub # [ 2.022702] systemd[1]: Starting Create List of Static Device Nodes...478hub # [ 2.028698] systemd[1]: Starting Load Kernel Module 9pnet_virtio...479hub # [ 2.040954] systemd[1]: Starting Load Kernel Module configfs...480hub # [ 2.054244] systemd[1]: Starting Journal Service...481hub # [ 2.071243] systemd[1]: Starting Load Kernel Modules...482hub # [ 2.081267] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os483hub # [ 2.097280] netfs: FS-Cache loaded484hub # [ 2.108547] 9pnet: Installing 9P2000 support485hub # [ 2.115749] systemd-journald[67]: Collecting audit messages is disabled.486hub # [ 2.126377] systemd[1]: Starting Coldplug All udev Devices...487hub # [ 2.146262] systemd[1]: Finished Create List of Static Device Nodes.488hub # [ 2.155912] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.489hub # [ 2.170813] systemd[1]: Finished Load Kernel Module 9pnet_virtio.490hub # [ 2.179720] systemd[1]: modprobe@configfs.service: Deactivated successfully.491hub # [ 2.184222] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.492hub # [ 2.191809] systemd[1]: Finished Load Kernel Module configfs.493hub # [ 2.198176] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev494hub # [ 2.201773] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config495hub # [ 2.220383] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...496hub # [ 2.242304] systemd[1]: Finished Load Kernel Modules.497hub # [ 2.254673] systemd[1]: Starting Apply Kernel Variables...498hub # [ 2.276311] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.499hub # [ 2.290404] systemd[1]: Starting Create Static Device Nodes in /dev...500hub # [ 2.310731] systemd[1]: Finished Apply Kernel Variables.501hub # [ 2.323729] systemd[1]: Started Journal Service.502hub # [ 2.078349] systemd-modules-load[68]: Inserted module 'dm_mod'503hub # [ 2.083582] systemd-modules-load[68]: Inserted module 'virtio_balloon'504hub # [ 2.089173] systemd-modules-load[68]: Inserted module 'virtio_gpu'505hub # [ 2.094227] systemd[1]: Finished Create Static Device Nodes in /dev.506hub # [ 2.105137] systemd[1]: Reached target Preparation for Local File Systems.507hub # [ 2.109108] systemd[1]: Reached target Local File Systems.508hub # [ 2.111358] systemd[1]: Starting Create System Files and Directories...509hub # [ 2.121113] systemd[1]: Starting Rule-based Manager for Device Events and Files...510hub # [ 2.153547] systemd[1]: Finished Create System Files and Directories.511hub # [ 2.176330] systemd-udevd[84]: Using default interface naming scheme 'v261'.512hub # [ 2.212116] systemd[1]: Started Rule-based Manager for Device Events and Files.513hub # [ 2.264223] systemd[1]: Finished Coldplug All udev Devices.514hub # [ 2.266847] systemd[1]: Reached target System Initialization.515hub # [ 2.269450] systemd[1]: Reached target Basic System.516worker: QEMU running (pid 48)517worker # Disk image does not exist, creating the virtualisation disk image...518worker # Formatting '/build/vm-state-worker/tmp.DnGqeKsjBc', fmt=raw size=1073741824519worker # mke2fs 1.47.4 (6-Mar-2025)520worker # Discarding device blocks: 0/262144 done521worker # Creating filesystem with 262144 4k blocks and 65536 inodes522worker # Filesystem UUID: 20f5011a-e81e-47e2-8fe8-50eb335bf0f9523worker # Superblock backups stored on blocks:524(finished: start all VMs, in 3.51 seconds)525worker # 32768, 98304, 163840, 229376526worker # 527worker # Allocating group tables: 0/8 done528worker # Writing inode tables: 0/8 done529worker # Creating journal (8192 blocks): done530worker # Writing superblocks and filesystem accounting information: 0/8 done531worker # 532worker # Virtualisation disk image created.533worker # Creating Nix store image...534worker # Created Nix store image.535hub: waiting for unit headscale536hub: waiting for the VM to finish booting537worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)538worker # 539worker # 540hub # [ 2.809545] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12541worker # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1900+7EF31900 CA00542worker # Press Ctrl-B to configure iPXE (PCI 00:03.0)...543worker # 544worker # 545worker # 546worker # 547worker # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1900 7EF31900 CB00548worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)...549worker # 550worker # 551hub # [ 2.850363] uhci_hcd 0000:00:01.2: UHCI Host Controller552hub # [ 2.851675] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1553hub # [ 2.857040] serio: i8042 KBD port at 0x60,0x64 irq 1554worker # Booting from ROM...555hub # [ 2.872327] serio: i8042 AUX port at 0x60,0x64 irq 12556hub # [ 2.882914] SCSI subsystem initialized557hub # [ 2.884642] virtio_blk virtio5: 1/0/0 default/read/poll queues558worker # Probing EDD (edd=off to disable)... ok559hub # [ 2.891447] uhci_hcd 0000:00:01.2: detected 2 ports560hub # [ 2.898658] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)561hub # [ 2.903693] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100562hub # [ 2.917571] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18563hub # [ 2.919511] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1564hub # [ 2.954964] usb usb1: Product: UHCI Host Controller565hub # [ 2.712256] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.566hub # [ 2.720391] systemd[1]: Starting Virtual Console Setup...567hub # [ 2.976366] usb usb1: Manufacturer: Linux 6.18.39 uhci_hcd568hub # [ 2.995366] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0569hub # [ 2.754734] (udev-worker)[102]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.570hub # [ 2.760109] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.571hub # [ 3.014323] usb usb1: SerialNumber: 0000:00:01.2572hub # [ 2.775467] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.573hub # [ 2.782670] systemd[1]: Finished Virtual Console Setup.574hub # [ 3.044254] hub 1-0:1.0: USB hub found575hub # [ 3.056636] hub 1-0:1.0: 2 ports detected576hub # [ 2.833115] systemd[1]: Found device /dev/disk/by-label/nixos.577hub # [ 2.834764] systemd[1]: Reached target Initrd Root Device.578hub # [ 2.837797] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...579hub # [ 3.103226] scsi host0: ata_piix580hub # [ 3.109718] scsi host1: ata_piix581hub # [ 3.114957] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0582hub # [ 2.874958] systemd-fsck[117]: nixos: clean, 12/65536 files, 13019/262144 blocks583hub # [ 3.124951] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0584hub # [ 2.884249] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.585hub # [ 2.894564] systemd[1]: Mounting /sysroot...586worker # [ 0.000000] Linux version 6.18.39 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 18 14:53:38 UTC 2026587worker # [ 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/mka0dp2wn4gwr2l6kkjpsw6g7mz4wslv-nixos-system-worker-test/init regInfo=/nix/store/5sg08x1k6maqa4xchrgbdzzk7lqbq1rj-closure-info/registration console=ttyS0,115200n8 console=tty0588worker # [ 0.000000] BIOS-provided physical RAM map:589worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable590worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved591worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved592worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable593worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved594worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved595worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved596worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved597worker # [ 0.000000] NX (Execute Disable) protection: active598worker # [ 0.000000] APIC: Static calls initialized599worker # [ 0.000000] SMBIOS 2.8 present.600worker # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014601worker # [ 0.000000] DMI: Memory slots populated: 1/1602worker # [ 0.000000] Hypervisor detected: KVM603worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000604worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00605worker # [ 0.000000] kvm-clock: using sched offset of 506522809 cycles606worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns607worker # [ 0.000005] tsc: Detected 2400.010 MHz processor608hub # [ 3.281892] ata2: found unknown device (class 0)609worker # [ 0.000811] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000610worker # [ 0.000849] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs611worker # [ 0.000851] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT612hub # [ 3.285029] usb 1-1: new full-speed USB device number 2 using uhci_hcd613worker # [ 0.002771] found SMP MP-table at [mem 0x000f5470-0x000f547f]614worker # [ 0.002782] Using GB pages for direct mapping615worker # [ 0.002857] RAMDISK: [mem 0x7e39c000-0x7ffcffff]616worker # [ 0.002864] ACPI: Early table checksum verification disabled617worker # [ 0.002867] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )618hub # [ 3.293028] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100619worker # [ 0.002871] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)620worker # [ 0.002875] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)621worker # [ 0.002882] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)622worker # [ 0.002884] ACPI: FACS 0x000000007FFE0000 000040623worker # [ 0.002885] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)624hub # [ 3.301210] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5625worker # [ 0.002887] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)626worker # [ 0.002888] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)627worker # [ 0.002890] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]628worker # [ 0.002891] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]629worker # [ 0.002891] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]630worker # [ 0.002892] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]631worker # [ 0.002892] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]632worker # [ 0.002893] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]633worker # [ 0.003375] No NUMA configuration found634worker # [ 0.003377] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]635worker # [ 0.003380] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]636worker # [ 0.005717] Zone ranges:637worker # [ 0.005717] DMA [mem 0x0000000000001000-0x0000000000ffffff]638worker # [ 0.005719] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff]639worker # [ 0.005720] Normal empty640worker # [ 0.005721] Device empty641worker # [ 0.005721] Movable zone start for each node642worker # [ 0.005722] Early memory node ranges643worker # [ 0.005723] node 0: [mem 0x0000000000001000-0x000000000009efff]644worker # [ 0.005724] node 0: [mem 0x0000000000100000-0x000000007ffd7fff]645worker # [ 0.005725] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]646worker # [ 0.005744] On node 0, zone DMA: 1 pages in unavailable ranges647worker # [ 0.006017] On node 0, zone DMA: 97 pages in unavailable ranges648worker # [ 0.042436] On node 0, zone DMA32: 40 pages in unavailable ranges649worker # [ 0.043442] ACPI: PM-Timer IO Port: 0x608650worker # [ 0.043457] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])651worker # [ 0.043506] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23652worker # [ 0.043509] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)653worker # [ 0.043511] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)654worker # [ 0.043512] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)655worker # [ 0.043513] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)656worker # [ 0.043514] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)657worker # [ 0.043516] ACPI: Using ACPI (MADT) for SMP configuration information658worker # [ 0.043518] ACPI: HPET id: 0x8086a201 base: 0xfed00000659worker # [ 0.043523] TSC deadline timer available660worker # [ 0.043527] CPU topo: Max. logical packages: 1661worker # [ 0.043528] CPU topo: Max. logical dies: 1662worker # [ 0.043529] CPU topo: Max. dies per package: 1663worker # [ 0.043532] CPU topo: Max. threads per core: 1664worker # [ 0.043532] CPU topo: Num. cores per package: 1665worker # [ 0.043533] CPU topo: Num. threads per package: 1666worker # [ 0.043533] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs667worker # [ 0.043552] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()668worker # [ 0.043590] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]669worker # [ 0.043592] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]670worker # [ 0.043593] [mem 0x80000000-0xfeffbfff] available for PCI devices671worker # [ 0.043594] Booting paravirtualized kernel on KVM672worker # [ 0.043597] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns673hub # [ 3.371941] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray674worker # [ 0.048039] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1675worker # [ 0.050283] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152676worker # [ 0.050330] kvm-guest: PV spinlocks disabled, single CPU677worker # [ 0.050332] 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/mka0dp2wn4gwr2l6kkjpsw6g7mz4wslv-nixos-system-worker-test/init regInfo=/nix/store/5sg08x1k6maqa4xchrgbdzzk7lqbq1rj-closure-info/registration console=ttyS0,115200n8 console=tty0678worker # [ 0.050422] Unknown kernel command line parameters "regInfo=/nix/store/5sg08x1k6maqa4xchrgbdzzk7lqbq1rj-closure-info/registration", will be passed to user space.679worker # [ 0.050434] random: crng init done680worker # [ 0.050434] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes681hub # [ 3.389574] cdrom: Uniform CD-ROM driver Revision: 3.20682worker # [ 0.052657] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)683worker # [ 0.053967] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)684worker # [ 0.054000] Fallback order for Node 0: 0685worker # [ 0.054003] Built 1 zonelists, mobility grouping on. Total pages: 524150686worker # [ 0.054003] Policy zone: DMA32687worker # [ 0.056532] mem auto-init: stack:all(zero), heap alloc:on, heap free:off688worker # [ 0.060159] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1689worker # [ 0.064691] allocated 4194304 bytes of page_ext690worker # [ 0.074362] ftrace: allocating 48593 entries in 192 pages691worker # [ 0.074364] ftrace: allocated 192 pages with 2 groups692worker # [ 0.075487] Dynamic Preempt: lazy693worker # [ 0.075622] rcu: Preemptible hierarchical RCU implementation.694worker # [ 0.075623] rcu: RCU event tracing is enabled.695worker # [ 0.075624] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.696worker # [ 0.075625] Trampoline variant of Tasks RCU enabled.697worker # [ 0.075626] Rude variant of Tasks RCU enabled.698worker # [ 0.075626] Tracing variant of Tasks RCU enabled.699worker # [ 0.075627] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.700hub # [ 3.413269] EXT4-fs (vda): mounted filesystem f9da0205-1485-41c9-b505-138371d9e86c r/w with ordered data mode. Quota mode: none.701worker # [ 0.075628] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1702worker # [ 0.075687] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.703hub # [ 3.172399] systemd[1]: Mounted /sysroot.704worker # [ 0.075688] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.705worker # [ 0.075689] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.706hub # [ 3.174532] systemd[1]: Reached target Initrd Root File System.707worker # [ 0.079969] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16708worker # [ 0.080243] rcu: srcu_init: Setting srcu_struct sizes based on contention.709worker # [ 0.080250] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns710hub # [ 3.180891] systemd[1]: Mounting /sysroot/nix/.ro-store...711worker # [ 0.080345] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)712worker # [ 0.087662] Console: colour VGA+ 80x25713worker # [ 0.087666] printk: legacy console [tty0] enabled714worker # [ 0.129436] printk: legacy console [ttyS0] enabled715worker # [ 0.319463] ACPI: Core revision 20250807716hub # [ 3.188208] systemd[1]: Mounting /sysroot/nix/.rw-store...717worker # [ 0.321025] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns718hub # [ 3.191146] systemd[1]: Mounting /sysroot/run...719worker # [ 0.323827] APIC: Switch to symmetric I/O mode setup720worker # [ 0.325581] x2apic enabled721worker # [ 0.326824] APIC: Switched APIC routing to: physical x2apic722worker # [ 0.329647] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1723worker # [ 0.331466] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns724hub # [ 3.202111] systemd[1]: Mounting /sysroot/tmp/shared...725worker # [ 0.334565] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)726worker # [ 0.336683] x86/cpu: User Mode Instruction Prevention (UMIP) activated727worker # [ 0.337727] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127728worker # [ 0.338564] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0729worker # [ 0.339568] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto730worker # [ 0.340564] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl731hub # [ 3.461580] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00732worker # [ 0.341564] Transient Scheduler Attacks: Mitigation: Clear CPU buffers733hub # [ 3.463538] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10734worker # [ 0.342563] Spectre V2 : Mitigation: Enhanced / Automatic IBRS735worker # [ 0.343564] Speculative Return Stack Overflow: Mitigation: Safe RET736hub # [ 3.221125] systemd[1]: Mounting /sysroot/tmp/xchg...737worker # [ 0.345564] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization738hub # [ 3.470624] usb 1-1: Product: QEMU USB Tablet739worker # [ 0.347573] Spectre V2 : Enabling IBPB for BPF740hub # [ 3.473154] usb 1-1: Manufacturer: QEMU741worker # [ 0.348566] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier742hub # [ 3.227977] systemd[1]: Starting Mountpoints Configured in the Real Root...743worker # [ 0.350564] active return thunk: srso_alias_return_thunk744hub # [ 3.476885] usb 1-1: SerialNumber: 28754-0000:00:01.2-1745worker # [ 0.352585] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'746worker # [ 0.354564] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'747worker # [ 0.355563] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'748worker # [ 0.356564] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'749worker # [ 0.357563] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'750worker # [ 0.358564] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'751worker # [ 0.359564] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'752worker # [ 0.360564] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'753worker # [ 0.361564] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'754worker # [ 0.363564] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256755worker # [ 0.364564] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64756worker # [ 0.365564] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512757worker # [ 0.366564] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024758worker # [ 0.368564] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8759worker # [ 0.370564] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16760worker # [ 0.371564] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24761worker # [ 0.372564] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.762hub # [ 3.524826] 9p: Installing v9fs 9p2000 file system support763hub # [ 3.529406] hid: raw HID events driver (C) Jiri Kosina764hub # [ 3.300740] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload.765worker # [ 0.406585] Freeing SMP alternatives memory: 44K766worker # [ 0.407566] pid_max: default: 32768 minimum: 301767worker # [ 0.409590] LSM: initializing lsm=capability,landlock,yama,bpf,ima768worker # [ 0.410685] landlock: Up and running.769worker # [ 0.412564] Yama: becoming mindful.770worker # [ 0.413774] LSM support for eBPF active771hub # [ 3.559567] usbcore: registered new interface driver usbhid772worker # [ 0.414690] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)773worker # [ 0.416606] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)774hub # [ 3.316177] systemd[1]: Mounted /sysroot/nix/.ro-store.775hub # [ 3.317639] systemd[1]: Mounted /sysroot/nix/.rw-store.776hub # [ 3.319146] systemd[1]: Mounted /sysroot/run.777worker # [ 0.419114] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)778worker # [ 0.420093] Performance Events: Fam17h+ core perfctr, AMD PMU driver.779worker # [ 0.420568] ... version: 2780hub # [ 3.323106] systemd[1]: Mounted /sysroot/tmp/shared.781worker # [ 0.421565] ... bit width: 48782hub # [ 3.324537] systemd[1]: Mounted /sysroot/tmp/xchg.783worker # [ 0.422620] ... generic counters: 6784worker # [ 0.423566] ... generic bitmap: 000000000000003f785hub # [ 3.574665] usbhid: USB HID core driver786worker # [ 0.424566] ... fixed-purpose counters: 0787worker # [ 0.425565] ... fixed-purpose bitmap: 0000000000000000788worker # [ 0.426565] ... value mask: 0000ffffffffffff789worker # [ 0.427565] ... max period: 00007fffffffffff790worker # [ 0.428566] ... global_ctrl mask: 000000000000003f791worker # [ 0.429679] signal: max sigframe size: 3376792worker # [ 0.430684] rcu: Hierarchical SRCU implementation.793worker # [ 0.431570] rcu: Max phase no-delay instances is 400.794hub # [ 3.338748] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)...795hub # [ 3.342149] systemd[1]: Reloading...796worker # [ 0.437048] smp: Bringing up secondary CPUs ...797worker # [ 0.437582] smp: Brought up 1 node, 1 CPU798worker # [ 0.438568] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)799worker # [ 0.439733] Memory: 1969880K/2096600K available (17150K kernel code, 2721K rwdata, 13544K rodata, 3640K init, 3012K bss, 117324K reserved, 0K cma-reserved)800worker # [ 0.440827] devtmpfs: initialized801worker # [ 0.441800] x86/mm: Memory block size: 128MB802hub # [ 3.602845] 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/input2803worker # [ 0.443750] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)804worker # [ 0.444602] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).805worker # [ 0.445667] pinctrl core: initialized pinctrl subsystem806hub # [ 3.610221] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0807worker # [ 0.446887] PM: RTC time: 11:07:36, date: 2026-08-01808worker # [ 0.450406] NET: Registered PF_NETLINK/PF_ROUTE protocol family809worker # [ 0.452105] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations810worker # [ 0.452592] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations811worker # [ 0.453856] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations812worker # [ 0.454578] audit: initializing netlink subsys (disabled)813worker # [ 0.455886] thermal_sys: Registered thermal governor 'fair_share'814worker # [ 0.455889] thermal_sys: Registered thermal governor 'bang_bang'815worker # [ 0.456580] audit: type=2000 audit(1785582456.367:1): state=initialized audit_enabled=0 res=1816worker # [ 0.458569] thermal_sys: Registered thermal governor 'step_wise'817worker # [ 0.458571] thermal_sys: Registered thermal governor 'user_space'818worker # [ 0.459566] thermal_sys: Registered thermal governor 'power_allocator'819worker # [ 0.460587] cpuidle: using governor menu820worker # [ 0.463762] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5821worker # [ 0.464867] PCI: Using configuration type 1 for base access822worker # [ 0.465566] PCI: Using configuration type 1 for extended access823worker # [ 0.466785] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.824worker # [ 0.473591] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages825worker # [ 0.474566] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page826worker # [ 0.479565] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages827worker # [ 0.480567] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page828worker # [ 0.491811] ACPI: Added _OSI(Module Device)829worker # [ 0.492566] ACPI: Added _OSI(Processor Device)830worker # [ 0.494354] ACPI: Added _OSI(Processor Aggregator Device)831worker # [ 0.499408] ACPI: 1 ACPI AML tables successfully acquired and loaded832worker # [ 0.506040] ACPI: Interpreter enabled833worker # [ 0.506583] ACPI: PM: (supports S0 S3 S4 S5)834worker # [ 0.507567] ACPI: Using IOAPIC for interrupt routing835hub # [ 3.452958] systemd[1]: Reloading finished in 110 ms.836worker # [ 0.508585] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug837worker # [ 0.511565] PCI: Using E820 reservations for host bridge windows838worker # [ 0.512714] ACPI: Enabled 2 GPEs in block 00 to 0F839hub # [ 3.462956] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace...840worker # [ 0.520665] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])841hub # [ 3.470087] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace...842worker # [ 0.521572] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]843hub # [ 3.472625] systemd[1]: Starting rw-sysroot-nix-store.service...844worker # [ 0.522968] acpiphp: Slot [3] registered845worker # [ 0.523609] acpiphp: Slot [4] registered846worker # [ 0.524620] acpiphp: Slot [5] registered847hub # [ 3.476748] systemd[1]: initrd-parse-etc.service: Deactivated successfully.848worker # [ 0.525608] acpiphp: Slot [6] registered849worker # [ 0.526606] acpiphp: Slot [7] registered850worker # [ 0.527613] acpiphp: Slot [8] registered851hub # [ 3.480222] systemd[1]: Finished Mountpoints Configured in the Real Root.852worker # [ 0.528663] acpiphp: Slot [9] registered853worker # [ 0.529609] acpiphp: Slot [10] registered854hub # [ 3.482904] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.855worker # [ 0.530607] acpiphp: Slot [11] registered856worker # [ 0.531620] acpiphp: Slot [12] registered857worker # [ 0.532608] acpiphp: Slot [13] registered858worker # [ 0.533599] acpiphp: Slot [14] registered859worker # [ 0.534599] acpiphp: Slot [15] registered860worker # [ 0.535621] acpiphp: Slot [16] registered861worker # [ 0.536623] acpiphp: Slot [17] registered862worker # [ 0.537598] acpiphp: Slot [18] registered863worker # [ 0.538613] acpiphp: Slot [19] registered864hub # [ 3.495467] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.865worker # [ 0.539620] acpiphp: Slot [20] registered866worker # [ 0.540600] acpiphp: Slot [21] registered867hub # [ 3.498124] systemd[1]: Finished rw-sysroot-nix-store.service.868worker # [ 0.541599] acpiphp: Slot [22] registered869worker # [ 0.542599] acpiphp: Slot [23] registered870worker # [ 0.543612] acpiphp: Slot [24] registered871worker # [ 0.544600] acpiphp: Slot [25] registered872worker # [ 0.545598] acpiphp: Slot [26] registered873worker # [ 0.546613] acpiphp: Slot [27] registered874worker # [ 0.547599] acpiphp: Slot [28] registered875worker # [ 0.548629] acpiphp: Slot [29] registered876worker # [ 0.549613] acpiphp: Slot [30] registered877worker # [ 0.550617] acpiphp: Slot [31] registered878worker # [ 0.551588] PCI host bridge to bus 0000:00879worker # [ 0.552573] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]880worker # [ 0.553567] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]881worker # [ 0.554566] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]882worker # [ 0.555566] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]883worker # [ 0.556566] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]884worker # [ 0.557567] pci_bus 0000:00: root bus resource [bus 00-ff]885worker # [ 0.558940] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint886worker # [ 0.560462] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint887worker # [ 0.562505] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint888worker # [ 0.565632] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f]889worker # [ 0.566631] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk890worker # [ 0.567566] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk891worker # [ 0.568567] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk892worker # [ 0.569566] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk893worker # [ 0.570889] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint894worker # [ 0.572632] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f]895worker # [ 0.574794] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint896worker # [ 0.576278] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI897worker # [ 0.577580] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB898worker # [ 0.578982] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint899worker # [ 0.581591] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]900worker # [ 0.582623] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]901worker # [ 0.583619] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]902worker # [ 0.584813] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]903worker # [ 0.586610] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint904worker # [ 0.589603] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]905worker # [ 0.590581] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]906worker # [ 0.591619] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]907worker # [ 0.592580] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]908worker # [ 0.596039] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint909worker # [ 0.598601] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f]910worker # [ 0.599580] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]911worker # [ 0.600619] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]912worker # [ 0.603643] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint913worker # [ 0.606304] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf]914worker # [ 0.607580] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]915worker # [ 0.608620] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]916worker # [ 0.611593] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint917worker # [ 0.615602] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df]918worker # [ 0.616581] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]919worker # [ 0.617619] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]920worker # [ 0.620593] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint921worker # [ 0.623600] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]922worker # [ 0.624581] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]923worker # [ 0.625619] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]924worker # [ 0.628918] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint925worker # [ 0.631506] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff]926worker # [ 0.632629] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]927worker # [ 0.633620] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]928worker # [ 0.636742] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint929worker # [ 0.638583] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff]930worker # [ 0.639580] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]931worker # [ 0.640619] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]932worker # [ 0.641580] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]933worker # [ 0.644592] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint934worker # [ 0.646593] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]935worker # [ 0.647619] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]936worker # [ 0.650546] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint937worker # [ 0.653580] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f]938worker # [ 0.654581] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]939worker # [ 0.655619] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]940worker # [ 0.658618] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint941worker # [ 0.661182] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f]942worker # [ 0.661581] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]943worker # [ 0.662619] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]944worker # [ 0.670916] ACPI: PCI: Interrupt link LNKA configured for IRQ 10945worker # [ 0.671776] ACPI: PCI: Interrupt link LNKB configured for IRQ 10946worker # [ 0.672761] ACPI: PCI: Interrupt link LNKC configured for IRQ 11947worker # [ 0.673755] ACPI: PCI: Interrupt link LNKD configured for IRQ 11948worker # [ 0.674679] ACPI: PCI: Interrupt link LNKS configured for IRQ 9949worker # [ 0.676723] iommu: Default domain type: Translated950worker # [ 0.677576] iommu: DMA domain TLB invalidation policy: lazy mode951worker # [ 0.678856] ACPI: bus type USB registered952worker # [ 0.679616] usbcore: registered new interface driver usbfs953worker # [ 0.680595] usbcore: registered new interface driver hub954worker # [ 0.681580] usbcore: registered new device driver usb955worker # [ 0.683655] NetLabel: Initializing956worker # [ 0.684565] NetLabel: domain hash size = 128957worker # [ 0.685565] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO958worker # [ 0.686645] NetLabel: unlabeled traffic allowed by default959worker # [ 0.687581] PCI: Using ACPI for IRQ routing960worker # [ 0.689205] pci 0000:00:02.0: vgaarb: setting as boot VGA device961worker # [ 0.689561] pci 0000:00:02.0: vgaarb: bridge control possible962worker # [ 0.689561] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none963worker # [ 0.689568] vgaarb: loaded964worker # [ 0.690707] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0965worker # [ 0.691566] hpet0: 3 comparators, 64-bit 100.000000 MHz counter966worker # [ 0.696645] clocksource: Switched to clocksource kvm-clock967worker # [ 0.700799] VFS: Disk quotas dquot_6.6.0968worker # [ 0.702088] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)969worker # [ 0.704363] pnp: PnP ACPI init970worker # [ 0.706025] pnp: PnP ACPI: found 6 devices971worker # [ 0.714333] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns972worker # [ 0.716938] clocksource: Switched to clocksource acpi_pm973worker # [ 0.718654] NET: Registered PF_INET protocol family974worker # [ 0.720610] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)975worker # [ 0.738716] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)976worker # [ 0.741440] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)977worker # [ 0.743780] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)978worker # [ 0.746183] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)979worker # [ 0.748459] TCP: Hash tables configured (established 16384 bind 16384)980worker # [ 0.750493] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)981worker # [ 0.752784] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)982worker # [ 0.754790] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)983worker # [ 0.756959] NET: Registered PF_UNIX/PF_LOCAL protocol family984worker # [ 0.758693] NET: Registered PF_XDP protocol family985worker # [ 0.760257] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]986worker # [ 0.762162] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]987worker # [ 0.764041] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]988worker # [ 0.766142] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]989worker # [ 0.768222] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]990worker # [ 0.770425] pci 0000:00:01.0: PIIX3: Enabling Passive Release991worker # [ 0.772216] pci 0000:00:00.0: Limiting direct PCI/PCI transfers992worker # [ 0.775651] ACPI: \_SB_.LNKD: Enabled at IRQ 11993worker # [ 0.779032] PCI: CLS 0 bytes, default 64994worker # [ 0.780599] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns995worker # [ 0.783641] Trying to unpack rootfs image as initramfs...996worker # [ 0.830773] Initialise system trusted keyrings997hub # [ 3.897230] systemd[1]: Mounting /sysroot/nix/store...998worker # [ 0.835407] workingset: timestamp_bits=40 max_order=19 bucket_order=0999worker # [ 0.860666] Key type asymmetric registered1000worker # [ 0.862021] Asymmetric key parser 'x509' registered1001worker # [ 0.867413] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)1002worker # [ 0.873412] io scheduler mq-deadline registered1003worker # [ 0.874851] io scheduler kyber registered1004hub # [ 3.946344] systemd[1]: Mounted /sysroot/nix/store.1005worker # [ 0.879546] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1006hub # [ 3.949109] systemd[1]: Reached target Initrd File Systems.1007worker # [ 0.881819] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1008hub # [ 3.951275] systemd[1]: Starting Find NixOS closure...1009hub # [ 3.956206] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1010worker # [ 0.890933] Linux agpgart interface v0.1031011worker # [ 0.894394] ACPI: bus type drm_connector registered1012worker # [ 0.899511] usbcore: registered new interface driver usbserial_generic1013worker # [ 0.901546] usbserial: USB Serial support registered for generic1014worker # [ 0.907390] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.1015worker # [ 0.907390] Please enable it if your BIOS has the CPPC option.1016hub # [ 3.978207] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1017worker # [ 0.911415] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1018hub # [ 3.983134] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1019worker # [ 0.919492] drop_monitor: Initializing network drop monitor service1020worker # [ 0.921521] NET: Registered PF_INET6 protocol family1021hub # [ 3.992177] systemd[1]: Finished Find NixOS closure.1022hub # [ 3.994288] systemd[1]: Reached target Initrd Default Target.1023worker # [ 0.927487] Segment Routing with IPv61024worker # [ 0.928715] In-situ OAM (IOAM) with IPv61025hub # [ 3.996782] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1026worker # [ 0.932775] IPI shorthand broadcast: enabled1027worker # [ 0.941829] sched_clock: Marking stable (694029690, 247310690)->(1142071391, -200731011)1028hub # [ 4.013747] systemd[1]: Stopped target Initrd Default Target.1029hub # [ 4.015844] systemd[1]: Stopped target Basic System.1030hub # [ 4.018227] systemd[1]: Stopped target Initrd Root Device.1031worker # [ 0.950626] registered taskstats version 11032hub # [ 4.019706] systemd[1]: Stopped target Path Units.1033worker # [ 0.952217] Loading compiled-in X.509 certificates1034hub # [ 4.021231] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1035hub # [ 4.023682] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1036hub # [ 4.026325] systemd[1]: Stopped target Slice Units.1037hub # [ 4.027839] systemd[1]: Stopped target Socket Units.1038hub # [ 4.030394] systemd[1]: Stopped target System Initialization.1039hub # [ 4.031926] systemd[1]: Stopped target Swaps.1040hub # [ 4.033242] systemd[1]: Stopped target Timer Units.1041hub # [ 4.035203] systemd[1]: dbus.socket: Deactivated successfully.1042hub # [ 4.036816] systemd[1]: Closed D-Bus System Message Bus Socket.1043hub # [ 4.038779] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1044hub # [ 4.041228] systemd[1]: Stopped Find NixOS closure.1045worker # [ 0.975145] Demotion targets for Node 0: null1046hub # [ 4.042935] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1047hub # [ 4.046240] systemd[1]: Starting rw-sysroot-nix-store.service...1048worker # [ 0.979400] Key type .fscrypt registered1049hub # [ 4.048192] systemd[1]: systemd-sysctl.service: Deactivated successfully.1050worker # [ 0.980683] Key type fscrypt-provisioning registered1051hub # [ 4.051191] systemd[1]: Stopped Apply Kernel Variables.1052worker # [ 0.984495] ima: No TPM chip found, activating TPM-bypass!1053hub # [ 4.052782] systemd[1]: systemd-modules-load.service: Deactivated successfully.1054worker # [ 0.986198] ima: Allocated hash algorithm: sha11055hub # [ 4.054594] systemd[1]: Stopped Load Kernel Modules.1056hub # [ 4.057056] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1057worker # [ 0.991389] ima: No architecture policies found1058hub # [ 4.059102] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1059worker # [ 0.993000] PM: Magic number: 6:317:1241060hub # [ 4.061107] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1061hub # [ 4.062972] systemd[1]: Stopped Create System Files and Directories.1062hub # [ 4.065349] systemd[1]: Stopped target Local File Systems.1063worker # [ 0.997196] RAS: Correctable Errors collector initialized.1064hub # [ 4.066967] systemd[1]: Stopped target Preparation for Local File Systems.1065hub # [ 4.069371] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1066hub # [ 4.072241] systemd[1]: Stopped Coldplug All udev Devices.1067worker # [ 1.007113] clk: Disabling unused clocks1068hub # [ 4.075218] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1069hub # [ 4.077201] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1070hub # [ 4.080167] systemd[1]: Stopped Virtual Console Setup.1071worker # [ 1.012366] PM: genpd: Disabling unused power domains1072hub # [ 4.088870] systemd[1]: initrd-cleanup.service: Deactivated successfully.1073hub # [ 4.095204] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1074hub # [ 4.103951] systemd[1]: systemd-udevd.service: Deactivated successfully.1075hub # [ 4.105902] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1076hub # [ 4.108567] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1077hub # [ 4.111178] systemd[1]: Finished rw-sysroot-nix-store.service.1078hub # [ 4.114568] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1079hub # [ 4.117246] systemd[1]: Closed udev Control Socket.1080hub # [ 4.119071] systemd[1]: Starting Cleanup udev Database...1081hub # [ 4.121250] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1082hub # [ 4.123266] systemd[1]: Stopped Create Static Device Nodes in /dev.1083hub # [ 4.124940] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1084hub # [ 4.128202] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1085hub # [ 4.130120] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1086hub # [ 4.131911] systemd[1]: Stopped Create List of Static Device Nodes.1087hub # [ 4.148260] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1088hub # [ 4.151177] systemd[1]: Finished Cleanup udev Database.1089hub # [ 4.153269] systemd[1]: Reached target Switch Root.1090hub # [ 4.155884] systemd[1]: Starting NixOS Activation...1091worker # [ 1.152386] Freeing initrd memory: 28880K1092worker # [ 1.156259] Freeing unused decrypted memory: 2028K1093worker # [ 1.159717] Freeing unused kernel image (initmem) memory: 3640K1094worker # [ 1.161605] Write protecting the kernel read-only data: 32768k1095worker # [ 1.164387] Freeing unused kernel image (text/rodata gap) memory: 1280K1096worker # [ 1.166824] Freeing unused kernel image (rodata/data gap) memory: 792K1097worker # [ 1.219879] x86/mm: Checked W+X mappings: passed, no W+X pages found.1098worker # [ 1.221819] Run /init as init process1099worker # [ 1.233214] systemd[1]: Inserted module 'autofs4'1100worker # [ 1.250303] fuse: init (API version 7.45)1101hub # [ 4.323421] initrd-nixos-activation-start[181]: booting system configuration /nix/store/ms9d16vahzlwa4jllfys4vsqjr45p7ff-nixos-system-hub-test1102worker # [ 1.257946] ACPI: \_SB_.LNKC: Enabled at IRQ 101103worker # [ 1.266651] ACPI: \_SB_.LNKA: Enabled at IRQ 101104worker # [ 1.271662] ACPI: \_SB_.LNKB: Enabled at IRQ 111105worker # [ 1.311278] systemd[1]: Successfully made /usr/ read-only.1106hub # [ 4.392364] initrd-nixos-activation-start[181]: running activation script...1107worker # [ 1.651228] 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)1108worker # [ 1.673164] systemd[1]: Detected virtualization kvm.1109worker # [ 1.677207] systemd[1]: Detected architecture x86-64.1110worker # [ 1.681237] systemd[1]: Running in initrd.1111worker # [ 1.685685] systemd[1]: Initializing machine ID from random generator.1112worker # [ 1.690948] systemd[1]: Hostname set to <worker>.1113hub # [ 4.822415] initrd-nixos-activation-start[204]: setting up /etc...1114worker # [ 1.913300] systemd[1]: bpf-restrict-fs: LSM BPF program attached1115worker # [ 1.973458] systemd[1]: Queued start job for default target Initrd Default Target.1116worker # [ 1.977993] systemd[1]: Created slice Slice /system/modprobe.1117worker # [ 1.980106] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1118worker # [ 1.982616] systemd[1]: Expecting device /dev/disk/by-label/nix-store...1119worker # [ 1.984752] systemd[1]: Expecting device /dev/disk/by-label/nixos...1120worker # [ 1.986763] systemd[1]: Reached target Path Units.1121worker # [ 1.988401] systemd[1]: Reached target Slice Units.1122worker # [ 1.990011] systemd[1]: Reached target Swaps.1123worker # [ 1.991550] systemd[1]: Reached target Timer Units.1124worker # [ 1.993422] systemd[1]: Listening on D-Bus System Message Bus Socket.1125worker # [ 1.995608] systemd[1]: Listening on Journal Socket (/dev/log).1126worker # [ 1.997689] systemd[1]: Listening on Journal Sockets.1127worker # [ 1.999533] systemd[1]: Listening on udev Control Socket.1128worker # [ 2.001430] systemd[1]: Listening on udev Kernel Socket.1129worker # [ 2.003145] systemd[1]: Reached target Socket Units.1130worker # [ 2.005879] systemd[1]: Starting Create List of Static Device Nodes...1131worker # [ 2.011817] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1132worker # [ 2.024210] systemd[1]: Starting Load Kernel Module configfs...1133worker # [ 2.038451] systemd[1]: Starting Journal Service...1134hub # [ 5.128298] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1135hub # [ 5.131121] systemd[1]: Finished NixOS Activation.1136hub # [ 5.134096] systemd[1]: Starting Switch Root...1137worker # [ 2.054445] systemd[1]: Starting Load Kernel Modules...1138worker # [ 2.072921] netfs: FS-Cache loaded1139worker # [ 2.078289] 9pnet: Installing 9P2000 support1140hub # [ 5.149069] systemd[1]: Switching root.1141worker # [ 2.085793] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1142worker # [ 2.098590] systemd[1]: Starting Coldplug All udev Devices...1143worker # [ 2.117584] systemd[1]: Finished Create List of Static Device Nodes.1144worker # [ 2.121508] systemd-journald[67]: Collecting audit messages is disabled.1145worker # [ 2.128123] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1146worker # [ 2.137907] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1147worker # [ 2.142959] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1148worker # [ 2.149899] systemd[1]: modprobe@configfs.service: Deactivated successfully.1149worker # [ 2.154494] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1150worker # [ 2.162008] systemd[1]: Finished Load Kernel Module configfs.1151worker # [ 2.173109] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1152worker # [ 2.189607] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1153worker # [ 2.208886] systemd[1]: Finished Load Kernel Modules.1154hub # [ 5.530775] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1155worker # [ 2.220750] systemd[1]: Starting Apply Kernel Variables...1156worker # [ 2.238917] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1157worker # [ 2.252714] systemd[1]: Starting Create Static Device Nodes in /dev...1158worker # [ 2.273484] systemd[1]: Finished Apply Kernel Variables.1159worker # [ 2.291536] systemd[1]: Finished Create Static Device Nodes in /dev.1160worker # [ 2.297715] systemd[1]: Reached target Preparation for Local File Systems.1161worker # [ 2.304451] systemd[1]: Reached target Local File Systems.1162worker # [ 2.313709] systemd[1]: Starting Rule-based Manager for Device Events and Files...1163worker # [ 2.329581] systemd[1]: Started Journal Service.1164worker # [ 2.080693] systemd-modules-load[68]: Inserted module 'dm_mod'1165worker # [ 2.085355] systemd-modules-load[68]: Inserted module 'virtio_balloon'1166worker # [ 2.088470] systemd-modules-load[68]: Inserted module 'virtio_gpu'1167worker # [ 2.115113] systemd[1]: Starting Create System Files and Directories...1168hub # [ 5.684574] NET: Registered PF_VSOCK protocol family1169worker # [ 2.144591] systemd-udevd[75]: Using default interface naming scheme 'v261'.1170worker # [ 2.147991] systemd[1]: Finished Create System Files and Directories.1171worker # [ 2.183190] systemd[1]: Started Rule-based Manager for Device Events and Files.1172worker # [ 2.239300] systemd[1]: Finished Coldplug All udev Devices.1173worker # [ 2.243671] systemd[1]: Reached target System Initialization.1174worker # [ 2.245843] systemd[1]: Reached target Basic System.1175hub # [ 6.067825] 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)1176hub # [ 6.074440] systemd[1]: Detected virtualization kvm.1177hub # [ 6.075701] systemd[1]: Detected architecture x86-64.1178hub # [ 6.077038] systemd[1]: Detected first boot.1179hub # [ 6.080935] systemd[1]: Initializing machine ID from random generator.1180worker # [ 2.774954] virtio_blk virtio4: 1/0/0 default/read/poll queues1181worker # [ 2.795204] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121182worker # [ 2.811804] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1183worker # [ 2.818529] uhci_hcd 0000:00:01.2: UHCI Host Controller1184worker # [ 2.824702] serio: i8042 KBD port at 0x60,0x64 irq 11185worker # [ 2.835955] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11186worker # [ 2.844270] SCSI subsystem initialized1187worker # [ 2.850165] serio: i8042 AUX port at 0x60,0x64 irq 121188worker # [ 2.853670] virtio_blk virtio5: 1/0/0 default/read/poll queues1189worker # [ 2.858616] uhci_hcd 0000:00:01.2: detected 2 ports1190worker # [ 2.867568] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1401191worker # [ 2.871384] virtio_blk virtio5: [vdb] 2089448 512-byte logical blocks (1.07 GB/1020 MiB)1192worker # [ 2.884593] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181193worker # [ 2.886516] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11194worker # [ 2.920159] usb usb1: Product: UHCI Host Controller1195worker # [ 2.937357] usb usb1: Manufacturer: Linux 6.18.39 uhci_hcd1196worker # [ 2.697149] systemd[1]: Starting Virtual Console Setup...1197worker # [ 2.704833] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1198worker # [ 2.965432] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01199worker # [ 2.970674] usb usb1: SerialNumber: 0000:00:01.21200worker # [ 2.733049] (udev-worker)[86]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1201worker # [ 2.736846] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1202worker # [ 2.743793] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1203worker # [ 2.749554] systemd[1]: Finished Virtual Console Setup.1204worker # [ 3.001968] hub 1-0:1.0: USB hub found1205hub # [ 6.322942] systemd[1]: bpf-restrict-fs: LSM BPF program attached1206worker # [ 3.011729] hub 1-0:1.0: 2 ports detected1207worker # [ 2.804953] systemd[1]: Found device /dev/disk/by-label/nixos.1208worker # [ 2.806625] systemd[1]: Reached target Initrd Root Device.1209worker # [ 2.809106] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1210worker # [ 2.822311] systemd[1]: Found device /dev/disk/by-label/nix-store.1211worker # [ 3.076596] scsi host0: ata_piix1212worker # [ 3.082626] scsi host1: ata_piix1213worker # [ 3.088865] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 01214worker # [ 3.096447] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 01215worker # [ 2.853646] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks1216worker # [ 2.861701] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1217worker # [ 2.867386] systemd[1]: Mounting /sysroot...1218hub # [ 6.460501] systemd[1]: Applying preset policy.1219worker # [ 3.248528] usb 1-1: new full-speed USB device number 2 using uhci_hcd1220worker # [ 3.256990] ata2: found unknown device (class 0)1221worker # [ 3.262816] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001222worker # [ 3.270074] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51223worker # [ 3.339116] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1224worker # [ 3.359771] cdrom: Uniform CD-ROM driver Revision: 3.201225worker # [ 3.378662] EXT4-fs (vda): mounted filesystem 20f5011a-e81e-47e2-8fe8-50eb335bf0f9 r/w with ordered data mode. Quota mode: none.1226worker # [ 3.138188] systemd[1]: Mounted /sysroot.1227worker # [ 3.140414] systemd[1]: Reached target Initrd Root File System.1228worker # [ 3.147143] systemd[1]: Mounting /sysroot/nix/.ro-store...1229worker # [ 3.152207] systemd[1]: Mounting /sysroot/nix/.rw-store...1230worker # [ 3.160176] systemd[1]: Mounting /sysroot/run...1231worker # [ 3.420132] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001232worker # [ 3.422176] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101233worker # [ 3.178632] systemd[1]: Mounting /sysroot/tmp/shared...1234worker # [ 3.429357] usb 1-1: Product: QEMU USB Tablet1235worker # [ 3.431369] usb 1-1: Manufacturer: QEMU1236worker # [ 3.434352] usb 1-1: SerialNumber: 28754-0000:00:01.2-11237worker # [ 3.188945] systemd[1]: Mounting /sysroot/tmp/xchg...1238worker # [ 3.206666] systemd[1]: Starting Mountpoints Configured in the Real Root...1239worker # [ 3.484866] hid: raw HID events driver (C) Jiri Kosina1240worker # [ 3.500841] erofs (device vdb): mounted with root inode @ nid 36.1241worker # [ 3.513929] usbcore: registered new interface driver usbhid1242worker # [ 3.270196] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload.1243worker # [ 3.525786] usbhid: USB HID core driver1244worker # [ 3.289144] systemd[1]: Mounted /sysroot/nix/.ro-store.1245worker # [ 3.294108] systemd[1]: Mounted /sysroot/nix/.rw-store.1246worker # [ 3.295613] systemd[1]: Mounted /sysroot/run.1247worker # [ 3.545380] 9p: Installing v9fs 9p2000 file system support1248worker # [ 3.308941] systemd[1]: Mounted /sysroot/tmp/shared.1249worker # [ 3.311232] systemd[1]: Mounted /sysroot/tmp/xchg.1250worker # [ 3.316947] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)...1251worker # [ 3.322107] systemd[1]: Reloading...1252worker # [ 3.571807] 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/input21253worker # [ 3.580241] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01254hub # [ 6.909153] systemd[1]: Populated /etc with preset unit settings.1255worker # [ 3.430445] systemd[1]: Reloading finished in 109 ms.1256worker # [ 3.441157] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace...1257worker # [ 3.448212] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace...1258worker # [ 3.450898] systemd[1]: Starting rw-sysroot-nix-store.service...1259worker # [ 3.454702] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1260worker # [ 3.458176] systemd[1]: Finished Mountpoints Configured in the Real Root.1261worker # [ 3.460212] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1262worker # [ 3.474140] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1263worker # [ 3.476782] systemd[1]: Finished rw-sysroot-nix-store.service.1264worker # [ 3.869172] systemd[1]: Mounting /sysroot/nix/store...1265hub # [ 7.436273] systemd[1]: initrd-switch-root.service: Deactivated successfully.1266hub # [ 7.438800] systemd[1]: Stopped initrd-switch-root.service.1267hub # [ 7.442529] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1268hub # [ 7.445691] systemd[1]: Created slice Slice /system/getty.1269hub # [ 7.447768] systemd[1]: Created slice User and Session Slice.1270hub # [ 7.449354] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1271hub # [ 7.451377] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1272hub # [ 7.453293] systemd[1]: Expecting device /dev/hvc0...1273hub # [ 7.454586] systemd[1]: Expecting device /dev/ttyS0...1274hub # [ 7.455944] systemd[1]: Reached target Local Encrypted Volumes.1275hub # [ 7.457519] systemd[1]: Stopped target initrd-fs.target.1276hub # [ 7.458864] systemd[1]: Stopped target initrd-root-fs.target.1277hub # [ 7.460319] systemd[1]: Stopped target initrd-switch-root.target.1278hub # [ 7.461869] systemd[1]: Reached target Virtual Machines and Containers.1279hub # [ 7.463522] systemd[1]: Reached target Path Units.1280hub # [ 7.464787] systemd[1]: Reached target Remote File Systems.1281hub # [ 7.466242] systemd[1]: Reached target Slice Units.1282hub # [ 7.467532] systemd[1]: Reached target Swaps.1283hub # [ 7.472230] systemd[1]: Listening on Query the User Interactively for a Password.1284hub # [ 7.477654] systemd[1]: Listening on Process Core Dump Socket.1285hub # [ 7.481999] systemd[1]: Listening on Credential Encryption/Decryption.1286worker # [ 3.921098] systemd[1]: Mounted /sysroot/nix/store.1287hub # [ 7.486199] systemd[1]: Listening on Factory Reset Management.1288worker # [ 3.924106] systemd[1]: Reached target Initrd File Systems.1289hub # [ 7.487800] systemd[1]: Listening on Hostname Service Socket.1290worker # [ 3.926149] systemd[1]: Starting Find NixOS closure...1291worker # [ 3.930097] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1292hub # [ 7.493458] systemd[1]: Starting Journal Log Access Socket...1293hub # [ 7.495840] systemd[1]: Listening on Journal Audit Socket.1294hub # [ 7.500066] systemd[1]: Listening on Console Output Muting Service Socket.1295hub # [ 7.502001] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1296hub # [ 7.504358] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1297hub # [ 7.506607] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1298worker # [ 3.953319] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1299hub # [ 7.520245] systemd[1]: Listening on Disk Repartitioning Service Socket.1300worker # [ 3.957136] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1301hub # [ 7.522063] systemd[1]: Listening on udev Control Socket.1302hub # [ 7.523655] systemd[1]: Listening on udev Varlink Socket.1303hub # [ 7.528782] systemd[1]: Mounting Huge Pages File System...1304worker # [ 3.966595] systemd[1]: Finished Find NixOS closure.1305worker # [ 3.968864] systemd[1]: Reached target Initrd Default Target.1306hub # [ 7.533242] systemd[1]: Mounting POSIX Message Queue File System...1307worker # [ 3.972080] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1308hub # [ 7.541231] systemd[1]: Mounting Kernel Debug File System...1309hub # [ 7.549549] systemd[1]: Mounting Kernel Trace File System...1310worker # [ 3.988298] systemd[1]: Stopped target Initrd Default Target.1311worker # [ 3.990416] systemd[1]: Stopped target Basic System.1312worker # [ 3.992212] systemd[1]: Stopped target Initrd Root Device.1313worker # [ 3.993863] systemd[1]: Stopped target Path Units.1314hub # [ 7.557899] systemd[1]: Starting Create List of Static Device Nodes...1315worker # [ 3.996350] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1316worker # [ 3.998340] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1317worker # [ 4.000545] systemd[1]: Stopped target Slice Units.1318hub # [ 7.563231] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1319worker # [ 4.002532] systemd[1]: Stopped target Socket Units.1320worker # [ 4.004391] systemd[1]: Stopped target System Initialization.1321worker # [ 4.006377] systemd[1]: Stopped target Swaps.1322worker # [ 4.008314] systemd[1]: Stopped target Timer Units.1323worker # [ 4.010232] systemd[1]: dbus.socket: Deactivated successfully.1324worker # [ 4.011825] systemd[1]: Closed D-Bus System Message Bus Socket.1325hub # [ 7.575600] systemd[1]: Starting Load Kernel Module configfs...1326worker # [ 4.013629] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1327worker # [ 4.016205] systemd[1]: Stopped Find NixOS closure.1328hub # [ 7.577991] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1329worker # [ 4.018216] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1330hub # [ 7.580561] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1331worker # [ 4.020978] systemd[1]: Starting rw-sysroot-nix-store.service...1332worker # [ 4.022994] systemd[1]: systemd-sysctl.service: Deactivated successfully.1333worker # [ 4.025352] systemd[1]: Stopped Apply Kernel Variables.1334worker # [ 4.027222] systemd[1]: systemd-modules-load.service: Deactivated successfully.1335hub # [ 7.590243] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1336worker # [ 4.030200] systemd[1]: Stopped Load Kernel Modules.1337worker # [ 4.031624] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1338worker # [ 4.033800] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1339worker # [ 4.035866] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1340worker # [ 4.038174] systemd[1]: Stopped Create System Files and Directories.1341worker # [ 4.040214] systemd[1]: Stopped target Local File Systems.1342worker # [ 4.041850] systemd[1]: Stopped target Preparation for Local File Systems.1343worker # [ 4.044200] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1344worker # [ 4.046209] systemd[1]: Stopped Coldplug All udev Devices.1345worker # [ 4.049225] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1346worker # [ 4.051221] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1347worker # [ 4.054214] systemd[1]: Stopped Virtual Console Setup.1348hub # [ 7.622714] systemd[1]: Mounting FUSE Control File System...1349worker # [ 4.067921] systemd[1]: initrd-cleanup.service: Deactivated successfully.1350hub # [ 7.630314] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671351worker # [ 4.074182] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1352worker # [ 4.079407] systemd[1]: systemd-udevd.service: Deactivated successfully.1353worker # [ 4.081451] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1354worker # [ 4.084239] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1355worker # [ 4.086838] systemd[1]: Finished rw-sysroot-nix-store.service.1356worker # [ 4.091588] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1357hub # [ 7.654700] systemd[1]: Starting Journal Service...1358worker # [ 4.093618] systemd[1]: Closed udev Control Socket.1359worker # [ 4.096850] systemd[1]: Starting Cleanup udev Database...1360hub # [ 7.660782] systemd[1]: Starting Load Kernel Modules...1361worker # [ 4.098388] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1362worker # [ 4.100375] systemd[1]: Stopped Create Static Device Nodes in /dev.1363worker # [ 4.103217] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1364worker # [ 4.105295] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1365worker # [ 4.107165] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1366worker # [ 4.108991] systemd[1]: Stopped Create List of Static Device Nodes.1367hub # [ 7.676385] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1368hub # [ 7.687864] systemd[1]: Starting Remount Root and Kernel File Systems...1369worker # [ 4.126128] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1370worker # [ 4.128887] systemd[1]: Finished Cleanup udev Database.1371worker # [ 4.131218] systemd[1]: Reached target Switch Root.1372worker # [ 4.133931] systemd[1]: Starting NixOS Activation...1373hub # [ 7.697745] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1374hub # [ 7.712025] systemd[1]: Starting Coldplug All udev Devices...1375hub # [ 7.730044] systemd-journald[274]: Collecting audit messages is enabled.1376hub # [ 7.737327] systemd[1]: Listening on Journal Log Access Socket.1377hub # [ 7.749196] systemd[1]: Mounted Huge Pages File System.1378worker # [ 4.189834] initrd-nixos-activation-start[183]: booting system configuration /nix/store/mka0dp2wn4gwr2l6kkjpsw6g7mz4wslv-nixos-system-worker-test1379hub # [ 7.756038] loop: module loaded1380hub # [ 7.757816] systemd[1]: Mounted POSIX Message Queue File System.1381hub # [ 7.766865] systemd[1]: Mounted Kernel Debug File System.1382worker # [ 4.209815] initrd-nixos-activation-start[183]: running activation script...1383hub # [ 7.773199] EXT4-fs (vda): re-mounted f9da0205-1485-41c9-b505-138371d9e86c.1384hub # [ 7.778404] systemd[1]: Mounted Kernel Trace File System.1385hub # [ 7.790348] systemd[1]: Finished Create List of Static Device Nodes.1386hub # [ 7.798649] systemd[1]: modprobe@configfs.service: Deactivated successfully.1387hub # [ 7.557510] systemd[1]: Queued start job for default target Multi-User System.1388hub # [ 7.563348] systemd[1]: systemd-journald.service: Deactivated successfully.1389hub # [ 7.812301] systemd[1]: Finished Load Kernel Module configfs.1390hub # [ 7.568888] systemd-modules-load[275]: Inserted module 'loop'1391hub # [ 7.572063] systemd-modules-load[275]: Inserted module 'tls'1392hub # [ 7.821499] systemd[1]: Started Journal Service.1393hub # [ 7.586173] systemd[1]: Mounted FUSE Control File System.1394hub # [ 7.591195] systemd[1]: Finished Load Kernel Modules.1395hub # [ 7.596099] systemd[1]: Finished Remount Root and Kernel File Systems.1396hub # [ 7.615107] systemd[1]: Listening on Disk Image Download Service Socket.1397hub # [ 7.620670] systemd-oomd[277]: No swap; memory pressure usage will be degraded1398hub # [ 7.627127] systemd[1]: Mounting Kernel Configuration File System...1399hub # [ 7.632481] systemd[1]: Starting Firewall...1400hub # [ 7.641907] systemd[1]: Starting Flush Journal to Persistent Storage...1401hub # [ 7.646428] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1402hub # [ 7.658249] systemd[1]: Starting Load/Save OS Random Seed...1403worker # [ 4.349735] initrd-nixos-activation-start[206]: setting up /etc...1404hub # [ 7.672263] systemd[1]: Starting Apply Kernel Variables...1405hub # [ 7.696127] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1406hub # [ 7.701691] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1407hub # [ 7.704355] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1408hub # [ 7.975237] systemd-journald[274]: Received client request to flush runtime journal.1409worker # [ 4.426863] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1410worker # [ 4.429617] systemd[1]: Finished NixOS Activation.1411worker # [ 4.432802] systemd[1]: Starting Switch Root...1412worker # [ 4.447674] systemd[1]: Switching root.1413worker # [ 4.824661] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1414hub # [ 7.952932] systemd[1]: Mounted Kernel Configuration File System.1415hub # [ 7.957689] systemd[1]: Finished Load/Save OS Random Seed.1416hub # [ 7.962352] systemd[1]: Reached target First Boot Complete.1417hub # [ 7.967821] systemd[1]: Finished Apply Kernel Variables.1418hub # [ 7.969886] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1419hub # [ 7.972698] systemd[1]: Starting Create Static Device Nodes in /dev...1420hub # [ 7.975577] systemd[1]: Finished Flush Journal to Persistent Storage.1421worker # [ 4.913117] NET: Registered PF_VSOCK protocol family1422hub # [ 8.002118] systemd[1]: Finished Create Static Device Nodes in /dev.1423hub # [ 8.003857] systemd[1]: Reached target Preparation for Local File Systems.1424hub # [ 8.009539] systemd[1]: Starting Rule-based Manager for Device Events and Files...1425hub # [ 8.089093] systemd[1]: Finished Coldplug All udev Devices.1426hub # [ 8.108640] systemd-udevd[317]: Using default interface naming scheme 'v261'.1427hub # [ 8.195066] systemd[1]: Mounting /run/wrappers...1428hub # [ 8.234162] systemd[1]: Mounted /run/wrappers.1429hub # [ 8.235514] systemd[1]: Reached target Local File Systems.1430hub # [ 8.240256] systemd[1]: Listening on Boot Loader Control Service Socket.1431hub # [ 8.244889] systemd[1]: Starting register-nix-paths.service...1432hub # [ 8.250637] systemd[1]: Starting Create SUID/SGID Wrappers...1433hub # [ 8.252836] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1434hub # [ 8.265197] systemd[1]: Starting Save Transient machine-id to Disk...1435hub # [ 8.278375] systemd[1]: Starting Create System Files and Directories...1436hub # [ 8.284567] systemd[1]: Started Rule-based Manager for Device Events and Files.1437worker # [ 5.276146] 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)1438hub # [ 8.365705] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1439worker # [ 5.299601] systemd[1]: Detected virtualization kvm.1440worker # [ 5.304029] systemd[1]: Detected architecture x86-64.1441hub # [ 8.376869] systemd[1]: Finished Save Transient machine-id to Disk.1442worker # [ 5.308478] systemd[1]: Detected first boot.1443worker # [ 5.314603] systemd[1]: Initializing machine ID from random generator.1444hub # [ 8.456609] systemd[1]: Finished Create System Files and Directories.1445hub # [ 8.470970] systemd[1]: Starting Rebuild Journal Catalog...1446hub # [ 8.484422] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1447hub # [ 8.570986] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1448hub # [ 8.621105] systemd[1]: Finished Rebuild Journal Catalog.1449worker # [ 5.553682] systemd[1]: bpf-restrict-fs: LSM BPF program attached1450hub # [ 8.633256] systemd[1]: Starting Update is Completed...1451hub # [ 8.693846] systemd[1]: Finished Update is Completed.1452worker # [ 5.670004] systemd[1]: Applying preset policy.1453hub # [ 8.827291] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1454worker # [ 5.802930] systemd[1]: Populated /etc with preset unit settings.1455worker # [ 5.907516] systemd[1]: initrd-switch-root.service: Deactivated successfully.1456worker # [ 5.910104] systemd[1]: Stopped initrd-switch-root.service.1457worker # [ 5.913722] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1458worker # [ 5.916946] systemd[1]: Created slice Slice /system/getty.1459worker # [ 5.919133] systemd[1]: Created slice User and Session Slice.1460worker # [ 5.920769] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1461worker # [ 5.922852] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1462worker # [ 5.924748] systemd[1]: Expecting device /dev/hvc0...1463worker # [ 5.926048] systemd[1]: Expecting device /dev/ttyS0...1464worker # [ 5.927471] systemd[1]: Reached target Local Encrypted Volumes.1465worker # [ 5.928960] systemd[1]: Stopped target initrd-fs.target.1466worker # [ 5.930365] systemd[1]: Stopped target initrd-root-fs.target.1467hub # [ 8.999155] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1468worker # [ 5.931825] systemd[1]: Stopped target initrd-switch-root.target.1469worker # [ 5.933392] systemd[1]: Reached target Virtual Machines and Containers.1470worker # [ 5.935034] systemd[1]: Reached target Path Units.1471hub # [ 9.002958] systemd[1]: Finished Create SUID/SGID Wrappers.1472worker # [ 5.936410] systemd[1]: Reached target Remote File Systems.1473worker # [ 5.937875] systemd[1]: Reached target Slice Units.1474worker # [ 5.939142] systemd[1]: Reached target Swaps.1475worker # [ 5.941184] systemd[1]: Listening on Query the User Interactively for a Password.1476worker # [ 5.944036] systemd[1]: Listening on Process Core Dump Socket.1477worker # [ 5.946178] systemd[1]: Listening on Credential Encryption/Decryption.1478worker # [ 5.948614] systemd[1]: Listening on Factory Reset Management.1479worker # [ 5.950224] systemd[1]: Listening on Hostname Service Socket.1480worker # [ 5.953653] systemd[1]: Starting Journal Log Access Socket...1481worker # [ 5.955559] systemd[1]: Listening on Journal Audit Socket.1482worker # [ 5.958703] systemd[1]: Listening on Console Output Muting Service Socket.1483worker # [ 5.960598] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1484worker # [ 5.962509] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1485worker # [ 5.964791] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1486worker # [ 5.968540] systemd[1]: Listening on Disk Repartitioning Service Socket.1487worker # [ 5.970376] systemd[1]: Listening on udev Control Socket.1488worker # [ 5.971910] systemd[1]: Listening on udev Varlink Socket.1489worker # [ 5.975414] systemd[1]: Mounting Huge Pages File System...1490hub # [ 9.049296] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1491worker # [ 5.982432] systemd[1]: Mounting POSIX Message Queue File System...1492worker # [ 5.991678] systemd[1]: Mounting Kernel Debug File System...1493worker # [ 6.003437] systemd[1]: Mounting Kernel Trace File System...1494worker # [ 6.017432] systemd[1]: Starting Create List of Static Device Nodes...1495worker # [ 6.028472] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1496worker # [ 6.040522] systemd[1]: Starting Load Kernel Module configfs...1497worker # [ 6.043420] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1498worker # [ 6.047737] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1499worker # [ 6.051089] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1500worker # [ 6.060574] systemd[1]: Mounting FUSE Control File System...1501hub # [ 9.133219] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1502worker # [ 6.063475] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671503worker # [ 6.077464] systemd[1]: Starting Journal Service...1504worker # [ 6.083516] systemd[1]: Starting Load Kernel Modules...1505worker # [ 6.090448] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1506worker # [ 6.099439] systemd[1]: Starting Remount Root and Kernel File Systems...1507worker # [ 6.102212] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1508hub # [ 9.174305] (udev-worker)[393]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1509worker # [ 6.112461] systemd[1]: Starting Coldplug All udev Devices...1510hub # [ 9.182367] (udev-worker)[393]: Network interface NamePolicy= disabled on kernel command line.1511hub # [ 9.186940] (udev-worker)[416]: Network interface NamePolicy= disabled on kernel command line.1512worker # [ 6.119687] systemd[1]: Listening on Journal Log Access Socket.1513worker # [ 6.123560] systemd[1]: Mounted Huge Pages File System.1514worker # [ 6.126575] systemd[1]: Mounted POSIX Message Queue File System.1515worker # [ 6.129588] systemd[1]: Mounted Kernel Debug File System.1516worker # [ 6.133410] systemd[1]: Mounted Kernel Trace File System.1517worker # [ 6.138474] systemd[1]: Finished Create List of Static Device Nodes.1518worker # [ 6.141800] systemd[1]: modprobe@configfs.service: Deactivated successfully.1519worker # [ 6.147434] systemd[1]: Finished Load Kernel Module configfs.1520worker # [ 6.150705] systemd[1]: Mounted FUSE Control File System.1521worker # [ 6.158432] systemd[1]: Mounting Kernel Configuration File System...1522worker # [ 6.173441] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1523worker # [ 6.197394] systemd-journald[276]: Collecting audit messages is enabled.1524worker # [ 6.206719] loop: module loaded1525worker # [ 6.207824] systemd[1]: Mounted Kernel Configuration File System.1526worker # [ 6.210354] EXT4-fs (vda): re-mounted 20f5011a-e81e-47e2-8fe8-50eb335bf0f9.1527worker # [ 6.218799] systemd[1]: Finished Load Kernel Modules.1528worker # [ 6.225441] systemd[1]: Starting Firewall...1529worker # [ 6.233442] systemd[1]: Starting Apply Kernel Variables...1530worker # [ 6.239966] systemd[1]: Finished Remount Root and Kernel File Systems.1531worker # [ 6.243879] systemd[1]: Listening on Disk Image Download Service Socket.1532worker # [ 6.248476] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1533worker # [ 6.260435] systemd[1]: Starting Load/Save OS Random Seed...1534worker # [ 6.263390] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1535hub # [ 9.338135] systemd[1]: Finished register-nix-paths.service.1536hub # [ 9.342114] systemd[1]: Reached target System Initialization.1537hub # [ 9.345137] systemd[1]: Started Discard unused filesystem blocks once a week.1538hub # [ 9.347834] systemd[1]: Started Daily Cleanup of Temporary Directories.1539hub # [ 9.350237] systemd[1]: Reached target Timer Units.1540hub # [ 9.352267] systemd[1]: Listening on D-Bus System Message Bus Socket.1541hub # [ 9.356703] systemd[1]: Listening on Nix Daemon Socket.1542hub # [ 9.358313] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1543hub # [ 9.362419] systemd[1]: Reached target Socket Units.1544hub # [ 9.364845] systemd[1]: Reached target Basic System.1545hub # [ 9.368096] systemd[1]: Started backdoor.service.1546hub # [ 9.376624] systemd[1]: Starting Import lastlog data into lastlog2 database...1547worker # [ 6.314112] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1548worker # [ 6.323437] systemd[1]: Starting Create Static Device Nodes in /dev...1549hub # [ 9.393173] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1550worker # [ 6.338831] systemd[1]: Finished Apply Kernel Variables.1551hub # [ 9.407585] systemd[1]: Starting Post-Boot Actions...1552worker # [ 6.345440] systemd[1]: Finished Load/Save OS Random Seed.1553worker # [ 6.347745] systemd[1]: Reached target First Boot Complete.1554worker # [ 6.353625] systemd[1]: Started Journal Service.1555hub # [ 9.423695] systemd[1]: Started Reset console on configuration changes.1556worker # [ 6.108442] systemd[1]: Queued start job for default target Multi-User System.1557worker # [ 6.111993] systemd[1]: Unnecessary job was removed for /dev/vdb.1558worker # [ 6.129142] systemd[1]: systemd-journald.service: Deactivated successfully.1559worker # [ 6.133725] systemd-modules-load[277]: Inserted module 'loop'1560hub # [ 9.449943] systemd[1]: Starting resolvconf update...1561worker # [ 6.144548] systemd[1]: Starting Flush Journal to Persistent Storage...1562worker # [ 6.181549] systemd-oomd[279]: No swap; memory pressure usage will be degraded1563hub # [ 9.498483] systemd[1]: Finished Firewall.1564worker # [ 6.191164] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1565hub # connecting to host...1566hub # [ 9.513176] systemd[1]: Condition check resulted in Virtio network device being skipped.1567worker # [ 6.450548] systemd-journald[276]: Received client request to flush runtime journal.1568hub # [ 9.536199] systemd[1]: Finished Post-Boot Actions.1569hub # [ 9.542800] nsncd[504]: Aug 01 11:07:42.375 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1570hub # [ 9.550362] systemd[1]: Started Name Service Cache Daemon (nsncd).1571hub: Guest shell says: b'Spawning backdoor root shell...\n'1572hub: connected to guest root shell1573hub # [ 9.564347] systemd[1]: Reached target Host and Network Name Lookups.1574hub: (connecting took 7.20 seconds)1575hub # [ 9.566250] systemd[1]: Reached target User and Group Name Lookups.1576hub: (finished: waiting for the VM to finish booting, in 7.20 seconds)1577hub # [ 9.578112] systemd[1]: Starting D-Bus System Message Bus...1578hub # [ 9.604277] systemd[1]: Starting User Login Management...1579hub # [ 9.613125] systemd[1]: Finished Import lastlog data into lastlog2 database.1580worker # [ 6.429367] systemd[1]: Finished Create Static Device Nodes in /dev.1581worker # [ 6.436412] systemd[1]: Reached target Preparation for Local File Systems.1582worker # [ 6.440808] systemd[1]: Starting Rule-based Manager for Device Events and Files...1583worker # [ 6.443202] systemd-udevd[313]: Using default interface naming scheme 'v261'.1584worker # [ 6.448292] systemd[1]: Started Rule-based Manager for Device Events and Files.1585worker # [ 6.450245] systemd[1]: Finished Flush Journal to Persistent Storage.1586hub # [ 9.774667] dbus-broker-launch[535]: Looking up NSS user entry for 'systemd-timesync'...1587hub # [ 9.798351] systemd-logind[539]: New seat seat0.1588hub # [ 9.802054] dbus-broker-launch[535]: NSS returned no entry for 'systemd-timesync'1589hub # [ 9.804972] dbus-broker-launch[535]: Invalid user-name in /nix/store/11h1dp638p40ljsid8ffys4fyxhgq858-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1590hub # [ 9.809298] systemd[1]: Started User Login Management.1591hub # [ 9.839936] systemd[1]: Stopped target Host and Network Name Lookups.1592hub # [ 9.843414] systemd[1]: Stopping Host and Network Name Lookups...1593hub # [ 9.846342] systemd[1]: Stopped target User and Group Name Lookups.1594hub # [ 9.848401] systemd[1]: Stopping User and Group Name Lookups...1595hub # [ 9.853589] systemd[1]: Starting linger-users.service...1596hub # [ 9.857857] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1597hub # [ 9.859754] systemd[1]: Started D-Bus System Message Bus.1598hub # [ 10.135949] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31599hub # [ 9.904333] dbus-broker-launch[535]: Ready1600hub # [ 9.913122] systemd[1]: nscd.service: Deactivated successfully.1601hub # [ 9.917115] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1602hub # [ 9.947344] systemd[1]: linger-users.service: Deactivated successfully.1603hub # [ 9.951738] systemd[1]: Finished linger-users.service.1604hub # [ 9.961201] systemd[1]: Finished resolvconf update.1605hub # [ 9.966247] systemd[1]: Reached target Preparation for Network.1606hub # [ 9.973382] systemd[1]: Starting DHCP Client...1607worker # [ 6.663284] systemd[1]: Finished Coldplug All udev Devices.1608hub # [ 9.979583] systemd[1]: Starting Address configuration of eth1...1609worker # [ 6.671140] systemd[1]: Mounting /run/wrappers...1610hub # [ 9.993210] systemd[1]: Starting Extra networking commands....1611hub # [ 10.007289] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1612worker # [ 6.698688] systemd[1]: Mounted /run/wrappers.1613worker # [ 6.701116] systemd[1]: Reached target Local File Systems.1614worker # [ 6.705355] systemd[1]: Listening on Boot Loader Control Service Socket.1615hub # [ 10.025212] systemd[1]: Starting Tailscale node agent...1616worker # [ 6.712912] systemd[1]: Starting register-nix-paths.service...1617hub # [ 10.277136] ACPI: button: Power Button [PWRF]1618worker # [ 6.717410] systemd[1]: Starting Create SUID/SGID Wrappers...1619worker # [ 6.720133] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1620worker # [ 6.727106] systemd[1]: Starting Save Transient machine-id to Disk...1621worker # [ 6.734104] systemd[1]: Starting Create System Files and Directories...1622worker # [ 6.787166] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1623hub # [ 10.108547] systemd[1]: Started Name Service Cache Daemon (nsncd).1624worker # [ 6.798136] systemd[1]: Finished Save Transient machine-id to Disk.1625hub # [ 10.111732] nsncd[610]: Aug 01 11:07:42.943 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1626hub # [ 10.370486] mousedev: PS/2 mouse device common for all mice1627hub # [ 10.126726] systemd[1]: Reached target Host and Network Name Lookups.1628hub # [ 10.128516] systemd[1]: Reached target User and Group Name Lookups.1629hub # [ 10.402464] rtc_cmos 00:05: RTC can wake from S41630worker # [ 6.855978] systemd[1]: Finished Create System Files and Directories.1631hub # [ 10.173542] network-addresses-eth1-start[608]: adding address 192.168.1.1/24... done1632worker # [ 6.859108] systemd[1]: Starting Rebuild Journal Catalog...1633worker # [ 6.869107] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1634hub # [ 10.196055] network-addresses-eth1-start[608]: adding address 2001:db8:1::1/64... done1635worker # [ 6.908468] systemd[1]: Finished Firewall.1636hub # [ 10.472945] Floppy drive(s): fd0 is 2.88M AMI BIOS1637hub # [ 10.477520] rtc_cmos 00:05: registered as rtc01638hub # [ 10.240900] systemd[1]: Finished Address configuration of eth1.1639worker # [ 6.936727] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1640hub # [ 10.490209] parport_pc 00:03: reported by Plug and Play ACPI1641hub # [ 10.528571] rtc_cmos 00:05: setting system clock to 2026-08-01T11:07:43 UTC (1785582463)1642hub # [ 10.544633] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1643hub # [ 10.305365] dhcpcd[622]: dhcpcd-10.3.2 starting1644worker # [ 6.992701] systemd[1]: Finished Rebuild Journal Catalog.1645hub # [ 10.556568] FDC 0 is a S82078B1646worker # [ 6.998958] systemd[1]: Starting Update is Completed...1647hub # [ 10.321962] dhcpcd[680]: dev: loaded udev1648hub # [ 10.600365] 8021q: 802.1Q VLAN Support v1.81649worker # [ 7.040896] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1650hub # [ 10.604432] 8021q: adding VLAN 0 to HW filter on device eth11651worker # [ 7.052061] systemd[1]: Finished Update is Completed.1652hub # [ 10.376966] systemd[1]: Finished Extra networking commands..1653hub # [ 10.384756] systemd[1]: Reached target Network.1654hub # [ 10.402280] systemd[1]: Starting Nginx Web Server...1655hub # [ 10.415489] systemd[1]: Starting Permit User Sessions...1656worker # [ 7.171583] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1657worker # [ 7.177172] systemd[1]: Finished Create SUID/SGID Wrappers.1658hub # [ 10.512430] systemd[1]: Finished Permit User Sessions.1659hub # [ 10.527109] systemd[1]: Started Getty on tty1.1660hub # [ 10.531605] systemd[1]: Reached target Login Prompts.1661worker # [ 7.247152] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1662hub # [ 10.824315] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1663hub # [ 10.616609] tailscaled[613]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1664worker # [ 7.331122] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1665hub # [ 10.653974] tailscaled[613]: logtail started1666hub # [ 10.659615] tailscaled[613]: Program starting: v1.98.8, Go 1.26.5: []string{"/nix/store/ax6n9rcfhx3x787vvg7hfgmmvrl32d30-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}1667hub # [ 10.665637] tailscaled[613]: LogID: 2d0f8a27d841928a4800a245790bf370b8d3a8c01d68f6ff70fa3948033989691668hub # [ 10.668698] tailscaled[613]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1669worker # [ 7.354427] (udev-worker)[351]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1670hub # [ 10.671766] tailscaled[613]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1671worker # [ 7.360333] systemd[1]: Finished register-nix-paths.service.1672hub # [ 10.676230] tailscaled[613]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1673worker # [ 7.363464] systemd[1]: Reached target System Initialization.1674worker # [ 7.365258] systemd[1]: Started Discard unused filesystem blocks once a week.1675worker # [ 7.368480] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line.1676worker # [ 7.372657] systemd[1]: Started Daily Cleanup of Temporary Directories.1677worker # [ 7.374427] systemd[1]: Reached target Timer Units.1678worker # [ 7.378247] systemd[1]: Listening on D-Bus System Message Bus Socket.1679worker # [ 7.383271] systemd[1]: Listening on Nix Daemon Socket.1680worker # [ 7.385336] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1681worker # [ 7.388251] systemd[1]: Listening on tribuchet-agent-1.socket.1682worker # [ 7.394106] systemd[1]: Listening on tribuchet-agent-2.socket.1683worker # [ 7.395716] systemd[1]: Listening on tribuchet-agent-3.socket.1684hub # [ 10.710246] dbus-broker-launch[535]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1685worker # [ 7.401420] systemd[1]: Listening on tribuchet-agent-4.socket.1686worker # [ 7.404118] systemd[1]: Reached target Socket Units.1687worker # [ 7.408258] systemd[1]: Reached target Basic System.1688worker # [ 7.416249] systemd[1]: Started backdoor.service.1689worker # [ 7.418275] (udev-worker)[351]: Network interface NamePolicy= disabled on kernel command line.1690worker # [ 7.429644] systemd[1]: Starting Import lastlog data into lastlog2 database...1691worker # [ 7.436172] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1692worker # [ 7.439613] systemd[1]: Starting Post-Boot Actions...1693hub # [ 10.756868] tailscaled[613]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1694hub # [ 10.761077] tailscaled[613]: dns: using "openresolv" mode1695worker # [ 7.449636] systemd[1]: Started Reset console on configuration changes.1696hub # [ 10.767253] tailscaled[613]: dns: using dns.openresolvManager1697worker # [ 7.457130] systemd[1]: Starting resolvconf update...1698worker # [ 7.458681] systemd[1]: Starting D-Bus System Message Bus...1699worker # [ 7.498416] systemd[1]: Finished Post-Boot Actions.1700worker # connecting to host...1701hub # [ 10.829377] dhcpcd[680]: eth0: waiting for carrier1702hub # [ 10.831406] dhcpcd[680]: eth0: carrier acquired1703worker # [ 7.531311] systemd[1]: Started Name Service Cache Daemon (nsncd).1704worker # [ 7.533003] systemd[1]: Reached target Host and Network Name Lookups.1705hub # [ 10.850235] dhcpcd[680]: DUID 00:01:00:01:32:00:90:00:52:54:00:12:34:561706hub # [ 10.852324] dhcpcd[680]: eth0: IAID 00:12:34:561707worker # [ 7.537796] systemd[1]: Reached target User and Group Name Lookups.1708hub # [ 10.855452] dhcpcd[680]: eth0: adding address fe80::5054:ff:fe12:34561709worker # [ 7.542875] systemd[1]: Starting User Login Management...1710worker # [ 7.544577] nsncd[500]: Aug 01 11:07:43.696 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1711hub # [ 10.871258] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41712hub # [ 10.867338] nginx-pre-start[704]: nginx: the configuration file /nix/store/4cl9z0nwpy8d7balh4lnzqlpz1zbx13c-nginx.conf syntax is ok1713hub # [ 10.870800] nginx-pre-start[704]: nginx: configuration file /nix/store/4cl9z0nwpy8d7balh4lnzqlpz1zbx13c-nginx.conf test is successful1714worker # [ 7.567956] systemd[1]: Finished Import lastlog data into lastlog2 database.1715hub # [ 10.883882] systemd[1]: Started Nginx Web Server.1716worker # [ 7.596326] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'...1717hub # [ 10.899045] cfg80211: Loading compiled-in X.509 certificates for regulatory database1718hub # [ 10.926255] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01719worker # [ 7.601950] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync'1720worker # [ 7.603885] dbus-broker-launch[504]: Invalid user-name in /nix/store/q2gwphismb9zq4n72i2sh692z34g16yf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1721worker # [ 7.620758] systemd[1]: Started D-Bus System Message Bus.1722worker # [ 7.651654] dbus-broker-launch[504]: Ready1723hub # [ 10.926328] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1724hub # [ 10.947437] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1725worker # [ 7.706710] systemd[1]: Stopped target Host and Network Name Lookups.1726worker # [ 7.708499] systemd[1]: Stopping Host and Network Name Lookups...1727worker # [ 7.710146] systemd[1]: Stopped target User and Group Name Lookups.1728worker # [ 7.718875] systemd[1]: Stopping User and Group Name Lookups...1729worker # [ 7.723231] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1730worker # [ 7.727736] systemd[1]: nscd.service: Deactivated successfully.1731worker # [ 7.732812] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1732worker # [ 7.736584] systemd[1]: nscd.service: Consumed 16ms CPU time over 324ms wall clock time, 6.9M memory peak, 5.5M read from disk.1733worker # [ 7.747270] systemd-logind[520]: New seat seat0.1734worker # [ 7.748827] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1735worker # [ 7.750486] systemd[1]: Started User Login Management.1736worker # [ 7.756893] systemd[1]: Starting linger-users.service...1737hub # [ 11.087124] systemd[1]: Starting Virtual Console Setup...1738worker # [ 7.778100] systemd[1]: Condition check resulted in Virtio network device being skipped.1739hub # [ 10.962284] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1740hub # [ 10.962400] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1741worker # [ 7.798186] systemd[1]: linger-users.service: Deactivated successfully.1742worker # [ 7.800339] systemd[1]: Finished linger-users.service.1743worker # [ 7.811145] systemd[1]: Started Name Service Cache Daemon (nsncd).1744worker # [ 7.812985] nsncd[575]: Aug 01 11:07:43.966 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1745worker # [ 7.817261] systemd[1]: Reached target Host and Network Name Lookups.1746worker # [ 7.820256] systemd[1]: Reached target User and Group Name Lookups.1747worker # [ 7.830509] systemd[1]: Finished resolvconf update.1748worker # [ 7.833853] systemd[1]: Reached target Preparation for Network.1749hub # [ 10.964344] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21750worker # [ 7.840120] systemd[1]: Starting DHCP Client...1751hub # [ 10.964352] cfg80211: failed to load regulatory.db1752worker # [ 7.845133] systemd[1]: Starting Address configuration of eth1...1753worker # [ 7.855113] systemd[1]: Starting Extra networking commands....1754hub # [ 10.988551] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61755hub # [ 10.988963] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51756worker # [ 7.859125] systemd[1]: Starting Tailscale node agent...1757hub # [ 11.074578] 8021q: adding VLAN 0 to HW filter on device eth01758hub # [ 11.110285] Console: switching to colour dummy device 80x251759hub # [ 11.438580] [drm] Found bochs VGA, ID 0xb0c5.1760hub # [ 11.438582] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1761hub # [ 11.166205] systemd-logind[539]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1762hub # [ 11.446747] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1763hub # [ 11.448898] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01764hub # [ 11.239173] systemd[1]: Started Tailscale node agent.1765hub # [ 11.243338] tailscaled[613]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1766worker # [ 7.960814] network-addresses-eth1-start[604]: adding address 192.168.1.2/24... done1767worker # [ 7.979115] network-addresses-eth1-start[604]: adding address 2001:db8:1::2/64... done1768hub # [ 11.506237] fbcon: bochs-drmdrmfb (fb0) is primary device1769hub # [ 11.523471] tun: Universal TUN/TAP device driver, 1.61770hub # [ 11.538042] Console: switching to colour frame buffer device 160x501771hub # [ 11.564262] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1772worker # [ 8.006968] systemd[1]: Finished Address configuration of eth1.1773hub # [ 11.359387] tailscaled[613]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1774hub # [ 11.361612] tailscaled[613]: dns: using "openresolv" mode1775hub # [ 11.379151] tailscaled[613]: dns: using dns.openresolvManager1776hub # [ 11.381264] tailscaled[613]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true}1777hub # [ 11.392543] tailscaled[613]: magicsock: disco key = d:9f248365323a2c6c1778hub # [ 11.394900] tailscaled[613]: Creating WireGuard device...1779hub # [ 11.398596] tailscaled[613]: Bringing WireGuard device up...1780hub # [ 11.400728] tailscaled[613]: Bringing router up...1781hub # [ 11.402524] tailscaled[613]: router: using firewall mode pref1782hub # [ 11.409733] tailscaled[613]: router: portUpdate(port=41641, network=udp6)1783hub # [ 11.416754] tailscaled[613]: external route: up1784hub # [ 11.666989] kvm_amd: TSC scaling supported1785hub # [ 11.671328] kvm_amd: Nested Virtualization enabled1786hub # [ 11.673951] kvm_amd: Nested Paging enabled1787hub # [ 11.675584] kvm_amd: LBR virtualization supported1788hub # [ 11.680054] kvm_amd: Virtual VMLOAD VMSAVE supported1789hub # [ 11.683251] kvm_amd: Virtual GIF supported1790hub # [ 11.684790] kvm_amd: Virtual NMI enabled1791worker # [ 8.138389] dhcpcd[619]: dhcpcd-10.3.2 starting1792worker # [ 8.147540] dhcpcd[674]: dev: loaded udev1793worker # [ 8.401758] 8021q: 802.1Q VLAN Support v1.81794hub # [ 11.471266] tailscaled[613]: router: default choosing iptables1795worker # [ 8.407348] 8021q: adding VLAN 0 to HW filter on device eth11796worker # [ 8.163677] systemd[1]: Finished Extra networking commands..1797worker # [ 8.165977] systemd[1]: Reached target Network.1798worker # [ 8.169462] systemd[1]: Starting Permit User Sessions...1799hub # [ 11.525902] tailscaled[613]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1800hub # [ 11.536192] tailscaled[613]: Clearing router settings...1801hub # [ 11.538305] tailscaled[613]: Starting network monitor...1802hub # [ 11.541707] tailscaled[613]: Engine created.1803hub # [ 11.546348] tailscaled[613]: router: portUpdate(port=41641, network=udp4)1804worker # [ 8.246385] systemd[1]: Finished Permit User Sessions.1805worker # [ 8.254120] systemd[1]: Started Getty on tty1.1806worker # [ 8.255459] systemd[1]: Reached target Login Prompts.1807hub # [ 11.578617] tailscaled[613]: pm: migrating "_daemon" profile to new format1808hub # [ 11.581247] tailscaled[613]: envknob: PORT="41641"1809worker # [ 8.274125] tailscaled[606]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1810hub # [ 11.589900] tailscaled[613]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1811hub # [ 11.593467] tailscaled[613]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1812hub # [ 11.601611] tailscaled[613]: got LocalBackend in 360ms1813hub # [ 11.603469] tailscaled[613]: Start1814hub # [ 11.605361] tailscaled[613]: ipnext: "conn25": skipping extension1815worker # [ 8.292096] tailscaled[606]: logtail started1816hub # [ 11.607324] tailscaled[613]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop1817worker # [ 8.295092] tailscaled[606]: Program starting: v1.98.8, Go 1.26.5: []string{"/nix/store/ax6n9rcfhx3x787vvg7hfgmmvrl32d30-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}1818worker # [ 8.301132] tailscaled[606]: LogID: 9f87e7a944febe85ee66099771b41beafbe01b463ccd260a9b373c03303ae6ec1819worker # [ 8.303252] tailscaled[606]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1820worker # [ 8.307902] tailscaled[606]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1821hub # [ 11.629429] tailscaled[613]: profile data directory: profile not found1822worker # [ 8.311883] tailscaled[606]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1823hub # [ 11.634113] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1824hub # [ 11.638446] tailscaled[613]: Backend: logs: be:2d0f8a27d841928a4800a245790bf370b8d3a8c01d68f6ff70fa394803398969 fe:1825worker # [ 8.321940] dbus-broker-launch[504]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1826worker # [ 8.573386] cfg80211: Loading compiled-in X.509 certificates for regulatory database1827hub # [ 11.641663] tailscaled[613]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1828hub # [ 11.644285] tailscaled[613]: blockEngineUpdates(true)1829hub # [ 11.647880] tailscaled[613]: wgengine: Reconfig: configuring router1830worker # [ 8.580871] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1831hub # [ 11.650252] tailscaled[613]: wgengine: Reconfig: user dialer1832worker # [ 8.583585] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1833hub # [ 11.652142] tailscaled[613]: wgengine: Reconfig: configuring DNS1834worker # [ 8.586403] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21835worker # [ 8.588429] cfg80211: failed to load regulatory.db1836hub # [ 11.655953] tailscaled[613]: health(warnable=wantrunning-false): error: Tailscale is stopped.1837hub # [ 11.659642] tailscaled[613]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1838hub # [ 11.662812] tailscaled[613]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1839hub # [ 11.664600] tailscaled[613]: dns: OScfg: {}1840hub # [ 11.666482] systemd-logind[539]: Watching system buttons on /dev/input/event2 (Power Button)1841worker # [ 8.356384] tailscaled[606]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1842worker # [ 8.359090] tailscaled[606]: dns: using "openresolv" mode1843hub # [ 11.922947] EDAC MC: Ver: 3.0.01844worker # [ 8.360879] tailscaled[606]: dns: using dns.openresolvManager1845worker # [ 8.637421] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31846worker # [ 8.645654] 8021q: adding VLAN 0 to HW filter on device eth01847worker # [ 8.402335] dhcpcd[674]: eth0: waiting for carrier1848worker # [ 8.404707] dhcpcd[674]: eth0: carrier acquired1849worker # [ 8.410994] dhcpcd[674]: DUID 00:01:00:01:32:00:90:00:52:54:00:12:34:561850worker # [ 8.413312] dhcpcd[674]: eth0: IAID 00:12:34:561851worker # [ 8.415285] dhcpcd[674]: eth0: adding address fe80::5054:ff:fe12:34561852hub # [ 11.982046] ppdev: user-space parallel port driver1853hub # [ 11.742708] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1854hub # [ 11.746959] systemd[1]: Stopped Virtual Console Setup.1855worker # [ 8.687687] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1856worker # [ 8.690412] mousedev: PS/2 mouse device common for all mice1857hub # [ 11.761699] systemd[1]: Starting Virtual Console Setup...1858worker # [ 8.698947] ACPI: button: Power Button [PWRF]1859worker # [ 8.703458] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01860worker # [ 8.708674] rtc_cmos 00:05: RTC can wake from S41861hub # [ 11.780184] (udev-worker)[779]: Network interface NamePolicy= disabled on kernel command line.1862hub # [ 11.797533] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1863hub # [ 11.825489] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1864hub # [ 11.832228] systemd[1]: Stopped Virtual Console Setup.1865hub # [ 11.841933] systemd[1]: Starting Virtual Console Setup...1866worker # [ 8.733947] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1867worker # [ 8.736695] parport_pc 00:03: reported by Plug and Play ACPI1868worker # [ 8.736825] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1869worker # [ 8.741462] rtc_cmos 00:05: registered as rtc01870worker # [ 8.741580] rtc_cmos 00:05: setting system clock to 2026-08-01T11:07:44 UTC (1785582464)1871worker # [ 8.741704] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1872worker # [ 8.742788] systemd-journald[276]: Time jumped backwards, rotating.1873worker # [ 8.745699] Floppy drive(s): fd0 is 2.88M AMI BIOS1874worker # [ 8.760933] FDC 0 is a S82078B1875worker # [ 8.808817] Console: switching to colour dummy device 80x251876worker # [ 8.685984] systemd[1]: Starting Virtual Console Setup...1877worker # [ 8.849538] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41878worker # [ 8.872003] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61879worker # [ 8.872418] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51880worker # [ 9.012902] [drm] Found bochs VGA, ID 0xb0c5.1881worker # [ 9.012904] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1882worker # [ 8.719239] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1883worker # [ 8.792874] systemd-logind[520]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1884worker # [ 9.050154] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1885worker # [ 9.051495] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01886worker # [ 8.814304] systemd-logind[520]: Watching system buttons on /dev/input/event2 (Power Button)1887worker # [ 8.826518] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1888worker # [ 8.832195] systemd[1]: Stopped Virtual Console Setup.1889worker # [ 8.841926] systemd[1]: Starting Virtual Console Setup...1890hub # [ 12.187498] dhcpcd[680]: eth0: soliciting a DHCP lease1891worker # [ 9.135351] ppdev: user-space parallel port driver1892worker # [ 8.890459] systemd-vconsole-setup[708]: Configuration of first virtual console was skipped, ignoring remaining ones.1893hub # [ 12.455515] NET: Registered PF_PACKET protocol family1894worker # [ 8.897651] systemd[1]: Finished Virtual Console Setup.1895hub # [ 12.213696] dhcpcd[680]: eth0: offered 10.0.2.15 from 10.0.2.21896hub # [ 12.217247] dhcpcd[680]: eth0: probing address 10.0.2.15/241897hub # [ 12.232455] systemd-vconsole-setup[800]: Configuration of first virtual console was skipped, ignoring remaining ones.1898hub # [ 12.238676] systemd[1]: Finished Virtual Console Setup.1899worker # [ 8.951599] systemd-logind[520]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1900worker # [ 8.962116] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1901worker # [ 8.965193] systemd[1]: Stopped Virtual Console Setup.1902worker # [ 8.966622] systemd[1]: Stopping Virtual Console Setup...1903worker # [ 8.970285] systemd[1]: Starting Virtual Console Setup...1904worker # [ 9.182372] fbcon: bochs-drmdrmfb (fb0) is primary device1905worker # [ 9.229592] Console: switching to colour frame buffer device 160x501906worker # [ 9.240343] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1907worker # [ 9.023899] systemd-vconsole-setup[712]: Configuration of first virtual console was skipped, ignoring remaining ones.1908worker # [ 9.033751] systemd[1]: Finished Virtual Console Setup.1909worker # [ 9.326133] kvm_amd: TSC scaling supported1910worker # [ 9.327032] kvm_amd: Nested Virtualization enabled1911worker # [ 9.328259] kvm_amd: Nested Paging enabled1912worker # [ 9.329236] kvm_amd: LBR virtualization supported1913worker # [ 9.330362] kvm_amd: Virtual VMLOAD VMSAVE supported1914worker # [ 9.331273] kvm_amd: Virtual GIF supported1915worker # [ 9.332410] kvm_amd: Virtual NMI enabled1916hub # [ 12.408245] dhcpcd[680]: eth0: soliciting an IPv6 router1917hub # [ 12.414785] dhcpcd[680]: eth0: Router Advertisement from fe80::21918hub # [ 12.418776] dhcpcd[680]: eth0: adding address fec0::5054:ff:fe12:3456/641919hub # [ 12.423926] dhcpcd[680]: eth0: adding route to fec0::/641920worker # [ 9.365453] EDAC MC: Ver: 3.0.01921hub # [ 12.429191] tailscaled[613]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2541922hub # [ 12.435656] tailscaled[613]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2541923hub # [ 12.440963] dhcpcd[680]: eth0: adding default route via fe80::21924hub # [ 12.564703] tailscaled[613]: 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::cef2:ac8c:90ff:c065/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::cef2:ac8c:90ff:c065/64] rebind-reason=[default-if-changed]1925hub # [ 12.589854] tailscaled[613]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1926hub # [ 12.595419] tailscaled[613]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1927hub # [ 12.601225] tailscaled[613]: dns: OScfg: {}1928hub # [ 12.674353] tailscaled[613]: wgengine: set DNS config again after major link change1929hub # [ 12.682257] tailscaled[613]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::cef2:ac8c:90ff:c065/64]1930hub # [ 12.685624] tailscaled[613]: magicsock: 0 active derp conns1931hub # [ 12.688394] tailscaled[613]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:48260->[::1]:53: read: connection refused (in 16ms), trying bootstrap...1932hub # [ 12.694962] tailscaled[613]: router: portUpdate(port=41641, network=udp6)1933hub # [ 12.696708] tailscaled[613]: router: portUpdate(port=41641, network=udp4)1934hub # [ 12.701356] tailscaled[613]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...1935hub # [ 12.705627] tailscaled[613]: 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 unreachable1936hub # [ 12.710455] tailscaled[613]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ...1937worker # [ 9.504630] systemd[1]: Started Tailscale node agent.1938worker # [ 9.507610] tailscaled[606]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1939worker # [ 9.760703] tun: Universal TUN/TAP device driver, 1.61940worker # [ 9.541125] tailscaled[606]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1941worker # [ 9.543196] tailscaled[606]: dns: using "openresolv" mode1942worker # [ 9.551709] tailscaled[606]: dns: using dns.openresolvManager1943worker # [ 9.554138] tailscaled[606]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true}1944worker # [ 9.564884] tailscaled[606]: magicsock: disco key = d:429241286b6334d91945worker # [ 9.567317] tailscaled[606]: Creating WireGuard device...1946worker # [ 9.569364] tailscaled[606]: Bringing WireGuard device up...1947worker # [ 9.577222] tailscaled[606]: Bringing router up...1948worker # [ 9.579737] tailscaled[606]: router: using firewall mode pref1949worker # [ 9.583482] tailscaled[606]: router: portUpdate(port=41641, network=udp6)1950worker # [ 9.587947] tailscaled[606]: external route: up1951worker # [ 9.607893] (udev-worker)[748]: Network interface NamePolicy= disabled on kernel command line.1952worker # [ 9.617081] tailscaled[606]: router: default choosing iptables1953worker # [ 9.636532] tailscaled[606]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1954worker # [ 9.641226] tailscaled[606]: Clearing router settings...1955worker # [ 9.642921] tailscaled[606]: Starting network monitor...1956worker # [ 9.644691] tailscaled[606]: Engine created.1957worker # [ 9.647092] tailscaled[606]: router: portUpdate(port=41641, network=udp4)1958worker # [ 9.653523] tailscaled[606]: pm: migrating "_daemon" profile to new format1959worker # [ 9.655544] tailscaled[606]: envknob: PORT="41641"1960worker # [ 9.657494] tailscaled[606]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1961worker # [ 9.659994] tailscaled[606]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1962worker # [ 9.663345] tailscaled[606]: got LocalBackend in 157ms1963worker # [ 9.665143] tailscaled[606]: Start1964worker # [ 9.666913] tailscaled[606]: ipnext: "conn25": skipping extension1965worker # [ 9.668453] tailscaled[606]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop1966worker # [ 9.671246] tailscaled[606]: profile data directory: profile not found1967worker # [ 9.674391] tailscaled[606]: Backend: logs: be:9f87e7a944febe85ee66099771b41beafbe01b463ccd260a9b373c03303ae6ec fe:1968worker # [ 9.676786] tailscaled[606]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1969worker # [ 9.678893] tailscaled[606]: blockEngineUpdates(true)1970worker # [ 9.680351] tailscaled[606]: wgengine: Reconfig: configuring router1971worker # [ 9.681930] tailscaled[606]: wgengine: Reconfig: user dialer1972worker # [ 9.683330] tailscaled[606]: wgengine: Reconfig: configuring DNS1973worker # [ 9.684839] tailscaled[606]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1974worker # [ 9.688093] tailscaled[606]: health(warnable=wantrunning-false): error: Tailscale is stopped.1975worker # [ 9.690128] tailscaled[606]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1976worker # [ 9.691941] tailscaled[606]: dns: OScfg: {}1977worker # [ 9.765616] dhcpcd[674]: eth0: soliciting a DHCP lease1978worker # [ 10.019255] NET: Registered PF_PACKET protocol family1979worker # [ 9.776550] dhcpcd[674]: eth0: offered 10.0.2.15 from 10.0.2.21980worker # [ 9.779233] dhcpcd[674]: eth0: probing address 10.0.2.15/241981worker # [ 10.059263] dhcpcd[674]: eth0: soliciting an IPv6 router1982worker # [ 10.065601] dhcpcd[674]: eth0: Router Advertisement from fe80::21983worker # [ 10.069558] tailscaled[606]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2541984worker # [ 10.074995] tailscaled[606]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2541985worker # [ 10.080335] dhcpcd[674]: eth0: adding address fec0::5054:ff:fe12:3456/641986worker # [ 10.084849] dhcpcd[674]: eth0: adding route to fec0::/641987worker # [ 10.088404] dhcpcd[674]: eth0: adding default route via fe80::21988worker # [ 10.301251] tailscaled[606]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:58513->[::1]:53: read: connection refused (in 3ms), trying bootstrap...1989worker # [ 10.308469] tailscaled[606]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ...1990worker # [ 10.311155] tailscaled[606]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable1991worker # [ 10.316837] tailscaled[606]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ...1992hub # [ 13.684792] tailscaled[613]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2551993hub # [ 14.005570] tailscaled[613]: monitor: RTM_NEWROUTE: src=, dst=fec0::cef2:ac8c:90ff:c065/128, gw=, outif=2, table=2551994worker # [ 10.665190] tailscaled[606]: 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::a645:29c2:dd58:6489/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::a645:29c2:dd58:6489/64] rebind-reason=[default-if-changed]1995worker # [ 10.701805] tailscaled[606]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1996worker # [ 10.708673] tailscaled[606]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1997worker # [ 10.715844] tailscaled[606]: dns: OScfg: {}1998worker # [ 10.733379] tailscaled[606]: wgengine: set DNS config again after major link change1999worker # [ 10.736799] tailscaled[606]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::a645:29c2:dd58:6489/64]2000worker # [ 10.740781] tailscaled[606]: magicsock: 0 active derp conns2001worker # [ 10.744244] tailscaled[606]: router: portUpdate(port=41641, network=udp6)2002worker # [ 10.746393] tailscaled[606]: router: portUpdate(port=41641, network=udp4)2003worker # [ 11.187849] tailscaled[606]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552004worker # [ 11.955856] tailscaled[606]: monitor: RTM_NEWROUTE: src=, dst=fec0::a645:29c2:dd58:6489/128, gw=, outif=2, table=2552005hub # [ 15.706883] tailscaled[613]: 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": context deadline exceeded2006hub # [ 15.719350] tailscaled[613]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ...2007hub # [ 15.728375] tailscaled[613]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable2008hub # [ 15.739402] tailscaled[613]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ...2009worker # [ 13.319904] tailscaled[606]: bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2010worker # [ 13.333343] tailscaled[606]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...2011worker # [ 13.339962] tailscaled[606]: 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 unreachable2012worker # [ 13.350117] tailscaled[606]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...2013hub # [ 17.356831] dhcpcd[680]: eth0: leased 10.0.2.15 for 86400 seconds2014hub # [ 17.363709] dhcpcd[680]: eth0: adding route to 10.0.2.0/242015hub # [ 17.370811] tailscaled[613]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552016hub # [ 17.378639] tailscaled[613]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552017hub # [ 17.385302] tailscaled[613]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542018hub # [ 17.392871] dhcpcd[680]: eth0: adding default route via 10.0.2.22019hub # [ 17.397502] tailscaled[613]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542020hub # [ 17.407863] tailscaled[613]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::cef2:ac8c:90ff:c065/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::cef2:ac8c:90ff:c065/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::cef2:ac8c:90ff:c065/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::cef2:ac8c:90ff:c065/64] rebind-reason=[ips-changed]2021hub # [ 17.440437] tailscaled[613]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2022hub # [ 17.442545] tailscaled[613]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2023hub # [ 17.444741] tailscaled[613]: dns: OScfg: {}2024hub # [ 17.551693] systemd[1]: Started DHCP Client.2025hub # [ 17.555311] systemd[1]: Reached target Network is Online.2026hub # [ 17.561187] systemd[1]: Started headscale coordination server for Tailscale.2027hub # [ 17.563474] systemd[1]: Reached target Multi-User System.2028hub # [ 17.565747] systemd[1]: Startup finished in 995ms (kernel) + 4.382s (initrd) + 12.187s (userspace) = 17.565s.2029hub: (finished: waiting for unit headscale, in 15.33 seconds)2030hub: waiting for TCP port 443 on localhost2031hub # Connection to localhost (::1) 443 port [tcp/https] succeeded!2032hub: (finished: waiting for TCP port 443 on localhost, in 0.07 seconds)2033hub: waiting for unit tailscaled2034hub: (finished: waiting for unit tailscaled, in 0.08 seconds)2035worker: waiting for unit tailscaled2036worker: waiting for the VM to finish booting2037worker: Guest shell says: b'Spawning backdoor root shell...\n'2038worker: connected to guest root shell2039worker: (connecting took 0.00 seconds)2040worker: (finished: waiting for the VM to finish booting, in 0.00 seconds)2041worker: (finished: waiting for unit tailscaled, in 0.03 seconds)2042hub: must succeed: headscale users create test2043hub # [ 17.947501] headscale-start[919]: 2026-08-01T11:07:51Z WRN2044hub # [ 17.949951] headscale-start[919]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed.2045hub # [ 17.964771] headscale-start[919]: 2026-08-01T11:07:51Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key2046hub # [ 17.969637] headscale-start[919]: 2026-08-01T11:07:51Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite2047hub # [ 18.073940] headscale-start[919]: 2026-08-01T11:07:51Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key2048hub # [ 18.082952] headscale-start[919]: 2026-08-01T11:07:51Z INF starting headscale commit=v0.29.2 version=0.29.22049hub # [ 18.086316] headscale-start[919]: 2026-08-01T11:07:51Z INF Clients with a lower minimum version will be rejected minimum_version=v1.802050hub # [ 18.089981] headscale-start[919]: 2026-08-01T11:07:51Z 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:[0x20e9219fa120]}2051hub # [ 18.095130] headscale-start[919]: 2026-08-01T11:07:51Z 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}2052hub # [ 18.106534] headscale-start[919]: 2026-08-01T11:07:51Z INF stun server started at [::]:34782053hub # [ 18.109582] headscale-start[919]: 2026-08-01T11:07:51Z INF HA subnet router health probing enabled interval=10000 timeout=50002054hub # [ 18.113880] headscale-start[919]: 2026-08-01T11:07:51Z WRN listening without TLS but ServerURL does not start with http://2055hub # [ 18.118105] headscale-start[919]: 2026-08-01T11:07:51Z INF listening and serving HTTP on: 127.0.0.1:80802056hub # [ 18.120383] headscale-start[919]: 2026-08-01T11:07:51Z INF metrics server disabled (metrics_listen_addr is empty)2057worker # [ 15.046376] dhcpcd[674]: eth0: leased 10.0.2.15 for 86400 seconds2058worker # [ 15.052994] dhcpcd[674]: eth0: adding route to 10.0.2.0/242059worker # [ 15.061662] tailscaled[606]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552060worker # [ 15.069602] tailscaled[606]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552061worker # [ 15.076503] dhcpcd[674]: eth0: adding default route via 10.0.2.22062worker # [ 15.083490] tailscaled[606]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542063worker # [ 15.092138] tailscaled[606]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542064worker # [ 15.102979] tailscaled[606]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::a645:29c2:dd58:6489/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::a645:29c2:dd58:6489/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::a645:29c2:dd58:6489/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::a645:29c2:dd58:6489/64] rebind-reason=[ips-changed]2065worker # [ 15.126471] tailscaled[606]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2066worker # [ 15.128955] tailscaled[606]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2067worker # [ 15.131349] tailscaled[606]: dns: OScfg: {}2068worker # [ 15.191256] systemd[1]: Started DHCP Client.2069worker # [ 15.194601] systemd[1]: Reached target Multi-User System.2070worker # [ 15.196380] systemd[1]: Startup finished in 978ms (kernel) + 3.663s (initrd) + 10.551s (userspace) = 15.194s.2071hub # [ 18.530963] tailscaled[613]: wgengine: set DNS config again after major link change2072hub # [ 18.539257] tailscaled[613]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::cef2:ac8c:90ff:c065/64]2073hub # [ 18.547348] tailscaled[613]: magicsock: 0 active derp conns2074hub # [ 18.556375] tailscaled[613]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152075hub # [ 18.562756] tailscaled[613]: router: portUpdate(port=41641, network=udp6)2076hub # [ 18.567460] tailscaled[613]: router: portUpdate(port=41641, network=udp4)2077hub # [ 18.569636] tailscaled[613]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2078hub # [ 18.730328] tailscaled[613]: 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": context deadline exceeded2079hub # [ 18.741375] tailscaled[613]: trying bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" ...2080hub # [ 18.748549] tailscaled[613]: 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 unreachable2081hub # [ 18.760513] tailscaled[613]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ...2082hub # [ 19.016627] headscale-start[919]: 2026-08-01T11:07:52Z INF user created user.name=test2083hub: (finished: must succeed: headscale users create test, in 1.16 seconds)2084hub: must succeed: headscale preauthkeys -u 1 create --reusable2085hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.13 seconds)2086hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-LrdBQYqGDWnI-VmqJfWlbkju_Ab1_tiRQWi77mdXGynzIFLRQJk3gv3s2-FGizQHtmjC8917ffldt --hostname hub2087hub # [ 19.235879] tailscaled[613]: localapi: [POST] /localapi/v0/check-prefs2088hub # [ 19.238914] tailscaled[613]: localapi: [POST] /localapi/v0/start2089hub # [ 19.240714] tailscaled[613]: Start2090hub # [ 19.242837] tailscaled[613]: 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]2091hub # [ 19.247207] tailscaled[613]: generating new machine key2092hub # [ 19.252929] tailscaled[613]: machine key written to store2093hub # [ 19.254586] tailscaled[613]: profile data directory: profile not found2094hub # [ 19.258098] tailscaled[613]: Backend: logs: be:2d0f8a27d841928a4800a245790bf370b8d3a8c01d68f6ff70fa394803398969 fe:2095hub # [ 19.260473] tailscaled[613]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2096hub # [ 19.262557] tailscaled[613]: blockEngineUpdates(true)2097hub # [ 19.269437] tailscaled[613]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2098hub # [ 19.272088] tailscaled[613]: Reconfig(down): no changes made to Engine config2099hub # [ 19.274316] tailscaled[613]: control: client.Shutdown ...2100hub # [ 19.276850] tailscaled[613]: control: mapRoutine: exiting2101hub # [ 19.278244] tailscaled[613]: health(warnable=wantrunning-false): ok2102hub # [ 19.279777] tailscaled[613]: control: authRoutine: exiting2103hub # [ 19.281179] tailscaled[613]: control: updateRoutine: exiting2104hub # [ 19.283091] tailscaled[613]: control: Client.Shutdown done.2105hub # [ 19.284833] tailscaled[613]: localapi: [POST] /localapi/v0/login-interactive2106hub # [ 19.286988] tailscaled[613]: StartLoginInteractiveAs("root"): url=false2107hub # [ 19.289988] tailscaled[613]: control: client.Login(2)2108hub # [ 19.292681] tailscaled[613]: control: LoginInteractive -> regen=true2109hub # [ 19.294427] tailscaled[613]: control: doLogin(regen=true, hasUrl=false)2110hub # [ 19.370421] tailscaled[613]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2111hub # [ 19.387234] headscale-start[919]: 2026-08-01T11:07:52Z INF http request bytes=176 elapsed=3.808864 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:56182 status=2002112hub # [ 19.395268] tailscaled[613]: control: control server key from https://hub: ts2021=[4ulS4], legacy=2113hub # [ 19.397411] tailscaled[613]: control: Generating a new nodekey.2114hub # [ 19.400682] tailscaled[613]: control: RegisterReq: onode= node=[cCeVI] fup=false nks=false2115worker # [ 16.168946] tailscaled[606]: wgengine: set DNS config again after major link change2116worker # [ 16.175990] tailscaled[606]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::a645:29c2:dd58:6489/64]2117worker # [ 16.185381] tailscaled[606]: magicsock: 0 active derp conns2118worker # [ 16.192981] tailscaled[606]: router: portUpdate(port=41641, network=udp6)2119worker # [ 16.199211] tailscaled[606]: router: portUpdate(port=41641, network=udp4)2120worker # [ 16.207203] tailscaled[606]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2121worker # [ 16.211333] tailscaled[606]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152122worker # [ 16.351292] tailscaled[606]: 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": context deadline exceeded2123worker # [ 16.361431] tailscaled[606]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ...2124worker # [ 16.373286] tailscaled[606]: bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 18.230.97.74:443: connect: network is unreachable2125worker # [ 16.384749] tailscaled[606]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ...2126hub # [ 20.116860] headscale-start[919]: 2026-08-01T11:07:53Z INF http request bytes=249 elapsed=693.757168 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:56186 status=2002127hub # [ 20.129599] tailscaled[613]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2128hub # [ 20.145380] tailscaled[613]: blockEngineUpdates(false)2129hub # [ 20.623259] headscale-start[919]: 2026-08-01T11:07:53Z INF http request bytes=0 elapsed=478.706093 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56186 status=2002130hub # [ 21.124484] headscale-start[919]: 2026-08-01T11:07:54Z INF node connected machine.key=[xadzb] node.expired=false node.id=1 node.is_tagged=false node.key=[cCeVI] node.name=hub node.online=true user.name=test2131hub # [ 21.140957] headscale-start[919]: 2026-08-01T11:07:54Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x20e9219324d0 component=poll machine.key=[xadzb] node.expired=false node.id=1 node.is_tagged=false node.key=[cCeVI] node.name=hub node.online=false omit_peers=false stream=true user.name=test2132hub # [ 21.183864] tailscaled[613]: health(warnable=not-in-map-poll): ok2133hub # [ 21.201374] tailscaled[613]: active login: test2134hub # [ 21.206376] tailscaled[613]: netmap: suggested exit node: no preferred DERP, try again later2135hub # [ 21.208605] tailscaled[613]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2136hub # [ 21.211990] tailscaled[613]: magicsock: SetPrivateKey called (init)2137hub # [ 21.213561] tailscaled[613]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers)2138hub # [ 21.215662] tailscaled[613]: wgengine: Reconfig: configuring router2139hub # [ 21.479543] tailscaled[613]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [0ms] (forced=false)2140hub # [ 21.482618] tailscaled[613]: magicsock: home is now derp-999 ()2141hub # [ 21.485989] tailscaled[613]: 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::cef2:ac8c:90ff:c065]:41641 (local)2142hub # [ 21.490655] tailscaled[613]: magicsock: adding connection to derp-999 for home-keep-alive2143hub # [ 21.493584] tailscaled[613]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2144hub # [ 21.496435] tailscaled[613]: derphttp.Client.Connect: connecting to derp-999 ()2145hub # [ 21.503967] tailscaled[613]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2146hub # [ 21.519178] tailscaled[613]: magicsock: derp-999 connected; connGen=12147hub # [ 21.749236] tailscaled[613]: bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2148hub # [ 21.753758] tailscaled[613]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...2149hub # [ 21.756975] tailscaled[613]: bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 144.202.67.195:443: connect: network is unreachable2150hub # [ 21.762461] tailscaled[613]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...2151hub # [ 21.769171] tailscaled[613]: router: enabling connmark-based rp_filter workaround2152hub # [ 21.873252] tailscaled[613]: wgengine: Reconfig: user dialer2153hub # [ 21.875672] tailscaled[613]: tsdial: bart table size: 22154hub # [ 21.877338] tailscaled[613]: wgengine: Reconfig: configuring DNS2155hub # [ 21.879162] tailscaled[613]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1}2156hub # [ 21.928390] tailscaled[613]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa}2157hub # [ 21.930783] tailscaled[613]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2158hub # [ 22.012761] systemd[1]: Stopped target Host and Network Name Lookups.2159hub # [ 22.016275] systemd[1]: Stopping Host and Network Name Lookups...2160hub # [ 22.018247] systemd[1]: Stopped target User and Group Name Lookups.2161hub # [ 22.020306] systemd[1]: Stopping User and Group Name Lookups...2162hub # [ 22.022972] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2163hub # [ 22.026424] systemd[1]: nscd.service: Deactivated successfully.2164hub # [ 22.028601] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2165hub # [ 22.040969] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2166hub # [ 22.077245] tailscaled[613]: peerapi: serving on http://100.64.0.1:584362167hub # [ 22.079686] tailscaled[613]: peerapi: serving on http://[fd7a:115c:a1e0::1]:597802168hub # [ 22.082578] tailscaled[613]: netmap: suggested exit node: ()2169hub # [ 22.091452] tailscaled[613]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2170hub # [ 22.097893] systemd[1]: Started Name Service Cache Daemon (nsncd).2171hub # [ 22.099704] nsncd[1071]: Aug 01 11:07:55.316 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2172hub # [ 22.104765] tailscaled[613]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2173hub # [ 22.107336] systemd[1]: Reached target Host and Network Name Lookups.2174hub # [ 22.110064] systemd[1]: Reached target User and Group Name Lookups.2175hub # [ 22.111798] tailscaled[613]: writing netmap to disk cache2176hub # [ 22.116107] tailscaled[613]: health(warnable=no-derp-connection): ok2177hub # [ 22.117679] tailscaled[613]: health(warnable=no-derp-connection): ok2178hub # [ 22.119263] tailscaled[613]: health(warnable=warming-up): ok2179hub # [ 22.121089] tailscaled[613]: [RATELIMIT] format("health(warnable=%s): ok")2180hub # [ 22.126275] headscale-start[919]: 2026-08-01T11:07:55Z INF http request bytes=0 elapsed=36.928716 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56186 status=2002181hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-LrdBQYqGDWnI-VmqJfWlbkju_Ab1_tiRQWi77mdXGynzIFLRQJk3gv3s2-FGizQHtmjC8917ffldt --hostname hub, in 2.97 seconds)2182worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-LrdBQYqGDWnI-VmqJfWlbkju_Ab1_tiRQWi77mdXGynzIFLRQJk3gv3s2-FGizQHtmjC8917ffldt --hostname tt-worker2183worker # [ 18.882624] tailscaled[606]: localapi: [POST] /localapi/v0/check-prefs2184worker # [ 18.885169] tailscaled[606]: localapi: [POST] /localapi/v0/start2185worker # [ 18.889410] tailscaled[606]: Start2186worker # [ 18.891896] tailscaled[606]: 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]2187worker # [ 18.898758] tailscaled[606]: generating new machine key2188worker # [ 18.904098] tailscaled[606]: machine key written to store2189worker # [ 18.905483] tailscaled[606]: profile data directory: profile not found2190worker # [ 18.907124] tailscaled[606]: Backend: logs: be:9f87e7a944febe85ee66099771b41beafbe01b463ccd260a9b373c03303ae6ec fe:2191worker # [ 18.911465] tailscaled[606]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2192worker # [ 18.914315] tailscaled[606]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2193worker # [ 18.916818] tailscaled[606]: blockEngineUpdates(true)2194worker # [ 18.918538] tailscaled[606]: Reconfig(down): no changes made to Engine config2195worker # [ 18.921479] tailscaled[606]: health(warnable=wantrunning-false): ok2196worker # [ 18.923075] tailscaled[606]: control: client.Shutdown ...2197worker # [ 18.924430] tailscaled[606]: control: mapRoutine: exiting2198worker # [ 18.926313] tailscaled[606]: control: authRoutine: exiting2199worker # [ 18.927973] tailscaled[606]: control: updateRoutine: exiting2200worker # [ 18.929934] tailscaled[606]: control: Client.Shutdown done.2201worker # [ 18.931740] tailscaled[606]: localapi: [POST] /localapi/v0/login-interactive2202worker # [ 18.933741] tailscaled[606]: StartLoginInteractiveAs("root"): url=false2203worker # [ 18.936525] tailscaled[606]: control: client.Login(2)2204worker # [ 18.938525] tailscaled[606]: control: LoginInteractive -> regen=true2205worker # [ 18.940459] tailscaled[606]: control: doLogin(regen=true, hasUrl=false)2206worker # [ 18.965653] tailscaled[606]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2207hub # [ 22.287575] headscale-start[919]: 2026-08-01T11:07:55Z INF http request bytes=176 elapsed=0.222933 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:56192 status=2002208worker # [ 18.983098] tailscaled[606]: control: control server key from https://hub: ts2021=[4ulS4], legacy=2209worker # [ 18.985253] tailscaled[606]: control: Generating a new nodekey.2210worker # [ 18.987865] tailscaled[606]: control: RegisterReq: onode= node=[NLOJc] fup=false nks=false2211hub # [ 22.351204] tailscaled[613]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2212hub # [ 22.632970] headscale-start[919]: 2026-08-01T11:07:55Z INF http request bytes=0 elapsed=496.672063 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56186 status=2002213worker # [ 19.374249] tailscaled[606]: bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2214worker # [ 19.384683] tailscaled[606]: trying bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" ...2215worker # [ 19.395351] tailscaled[606]: 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 unreachable2216worker # [ 19.407641] tailscaled[606]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ...2217hub # [ 22.896405] tailscaled[613]: netmap: suggested exit node: ()2218hub # [ 22.905134] tailscaled[613]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2219hub # [ 22.916220] tailscaled[613]: netmap: suggested exit node: ()2220hub # [ 23.130834] headscale-start[919]: 2026-08-01T11:07:56Z INF http request bytes=0 elapsed=480.333395 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56186 status=2002221hub # [ 23.147284] headscale-start[919]: 2026-08-01T11:07:56Z INF http request bytes=249 elapsed=815.860396 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:56202 status=2002222worker # [ 19.842252] tailscaled[606]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2223worker # [ 19.855642] tailscaled[606]: blockEngineUpdates(false)2224hub # [ 23.632984] headscale-start[919]: 2026-08-01T11:07:56Z INF http request bytes=0 elapsed=461.026192 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56202 status=2002225hub # [ 23.703959] tailscaled[613]: netmap: suggested exit node: ()2226hub # [ 23.718244] tailscaled[613]: netmap: suggested exit node: ()2227hub # [ 23.721795] tailscaled[613]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)")2228hub # [ 23.729602] tailscaled[613]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2229hub # [ 23.734403] tailscaled[613]: wgengine: Reconfig: configuring router2230hub # [ 23.738786] tailscaled[613]: wgengine: Reconfig: user dialer2231hub # [ 23.741677] tailscaled[613]: tsdial: bart table size: 42232hub # [ 23.745289] tailscaled[613]: wgengine: Reconfig: configuring DNS2233hub # [ 23.747472] tailscaled[613]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2234hub # [ 23.799967] tailscaled[613]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2235hub # [ 23.802331] tailscaled[613]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2236hub # [ 24.008305] tailscaled[613]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2237hub # [ 24.138468] headscale-start[919]: 2026-08-01T11:07:57Z INF http request bytes=0 elapsed=115.502389 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56186 status=2002238hub # [ 24.149764] headscale-start[919]: 2026-08-01T11:07:57Z INF node connected machine.key=[Kb7va] node.expired=false node.id=2 node.is_tagged=false node.key=[NLOJc] node.name=tt-worker node.online=true user.name=test2239hub # [ 24.159647] headscale-start[919]: 2026-08-01T11:07:57Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x20e92192d1f0 component=poll machine.key=[Kb7va] node.expired=false node.id=2 node.is_tagged=false node.key=[NLOJc] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test2240worker # [ 20.880214] tailscaled[606]: health(warnable=not-in-map-poll): ok2241worker # [ 20.900287] tailscaled[606]: active login: test2242worker # [ 20.917576] tailscaled[606]: netmap: suggested exit node: no preferred DERP, try again later2243worker # [ 20.925191] tailscaled[606]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2244worker # [ 20.931316] tailscaled[606]: magicsock: SetPrivateKey called (init)2245worker # [ 20.937101] tailscaled[606]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2246worker # [ 20.942318] tailscaled[606]: wgengine: Reconfig: configuring router2247worker # [ 21.095684] tailscaled[606]: router: enabling connmark-based rp_filter workaround2248worker # [ 21.122219] tailscaled[606]: wgengine: Reconfig: user dialer2249worker # [ 21.123969] tailscaled[606]: tsdial: bart table size: 42250worker # [ 21.125754] tailscaled[606]: wgengine: Reconfig: configuring DNS2251worker # [ 21.127369] tailscaled[606]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2252worker # [ 21.145559] tailscaled[606]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2253worker # [ 21.148339] tailscaled[606]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2254worker # [ 21.161121] tailscaled[606]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [19ms] (forced=false)2255worker # [ 21.163429] tailscaled[606]: magicsock: home is now derp-999 ()2256worker # [ 21.167105] tailscaled[606]: magicsock: adding connection to derp-999 for home-keep-alive2257worker # [ 21.169062] tailscaled[606]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2258worker # [ 21.170799] tailscaled[606]: derphttp.Client.Connect: connecting to derp-999 ()2259worker # [ 21.175068] tailscaled[606]: 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::a645:29c2:dd58:6489]:41641 (local)2260worker # [ 21.187714] tailscaled[606]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2261worker # [ 21.207113] tailscaled[606]: magicsock: derp-999 connected; connGen=12262worker # [ 21.222844] systemd[1]: Stopped target Host and Network Name Lookups.2263worker # [ 21.228532] systemd[1]: Stopping Host and Network Name Lookups...2264worker # [ 21.230279] systemd[1]: Stopped target User and Group Name Lookups.2265worker # [ 21.232295] systemd[1]: Stopping User and Group Name Lookups...2266worker # [ 21.234293] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2267worker # [ 21.236230] systemd[1]: nscd.service: Deactivated successfully.2268worker # [ 21.238192] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2269worker # [ 21.250732] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2270worker # [ 21.266515] tailscaled[606]: peerapi: serving on http://100.64.0.2:465902271worker # [ 21.268396] tailscaled[606]: peerapi: serving on http://[fd7a:115c:a1e0::2]:471662272worker # [ 21.273764] tailscaled[606]: netmap: suggested exit node: ()2273worker # [ 21.280526] tailscaled[606]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2274worker # [ 21.287112] tailscaled[606]: writing netmap to disk cache2275worker # [ 21.290936] systemd[1]: Started Name Service Cache Daemon (nsncd).2276worker # [ 21.292684] systemd[1]: Reached target Host and Network Name Lookups.2277worker # [ 21.295210] systemd[1]: Reached target User and Group Name Lookups.2278worker # [ 21.298663] nsncd[957]: Aug 01 11:07:57.302 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2279worker # [ 21.305117] tailscaled[606]: health(warnable=no-derp-connection): ok2280worker # [ 21.306717] tailscaled[606]: health(warnable=no-derp-connection): ok2281worker # [ 21.308275] tailscaled[606]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2282worker # [ 21.311952] tailscaled[606]: health(warnable=no-derp-connection): ok2283worker # [ 21.313814] tailscaled[606]: [RATELIMIT] format("health(warnable=%s): ok")2284worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-LrdBQYqGDWnI-VmqJfWlbkju_Ab1_tiRQWi77mdXGynzIFLRQJk3gv3s2-FGizQHtmjC8917ffldt --hostname tt-worker, in 2.50 seconds)2285worker: waiting for success: tailscale ping hub2286hub # [ 24.636265] headscale-start[919]: 2026-08-01T11:07:57Z INF http request bytes=0 elapsed=35.874392 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56202 status=2002287worker # [ 21.348985] tailscaled[606]: localapi: [POST] /localapi/v0/ping2288worker # [ 21.350962] tailscaled[606]: ping(100.64.0.1): sending disco ping to [cCeVI] hub ...2289worker # [ 21.359534] tailscaled[606]: magicsock: disco: node [cCeVI] d:9f248365323a2c6c now using 192.168.1.1:41641 mtu=1360 tx=287ce1c874c42290worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds)2291hub: must succeed: tailscale ip -42292hub: (finished: must succeed: tailscale ip -4, in 0.07 seconds)2293worker: 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.toml2294worker: (finished: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml, in 0.02 seconds)2295hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub2296hub # [ 24.766429] tailscaled[613]: 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": context deadline exceeded2297hub # [ 24.771563] tailscaled[613]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ...2298hub # [ 24.775306] tailscaled[613]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable2299hub # [ 24.780139] tailscaled[613]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ...2300hub # [ 24.815153] systemd[1]: Starting tribuchet-hub.socket...2301hub # [ 24.825828] systemd[1]: Listening on tribuchet-hub.socket.2302hub # [ 24.831113] systemd[1]: Starting tribuchet-hub.service...2303hub # [ 24.907586] tribuchet[1115]: 2026-08-01T11:07:58.124241Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[]2304hub # [ 24.912922] tribuchet[1115]: 2026-08-01T11:07:58.125740Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers2305hub # [ 24.917562] tribuchet[1115]: 2026-08-01T11:07:58.130987Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true2306hub # [ 24.924846] tribuchet[1115]: 2026-08-01T11:07:58.143218Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock2307hub # [ 24.929184] systemd[1]: Started tribuchet-hub.service.2308hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.17 seconds)2309worker: must succeed: systemctl start tribuchet-worker2310worker # [ 21.668225] systemd[1]: Starting tribuchet-worker.service...2311worker # [ 21.719344] tribuchet[995]: 2026-08-01T11:07:57.724003Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock", "/run/tribuchet/agents/3.sock", "/run/tribuchet/agents/4.sock"], spawn_agents: 0, agent_uid_base: None }2312worker # [ 21.737132] tribuchet[995]: 2026-08-01T11:07:57.742410Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/48czgycdvysxqlbgi6rgvx9cl4kl8mml-busybox-1.37.0/bin/busybox")2313worker # [ 21.742447] systemd[1]: Started tribuchet-worker.service.2314worker # [ 21.751297] systemd[1]: Started tribuchet-agent-1.service.2315worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.13 seconds)2316hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"'2317worker # [ 21.774218] r3f1wmjw38qyj7k7bb5318l2khs55fsz-tribuchet-agent-1[998]: 2026-08-01T11:07:57.779453Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362318worker # [ 21.781303] r3f1wmjw38qyj7k7bb5318l2khs55fsz-tribuchet-agent-1[998]: 2026-08-01T11:07:57.779502Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2319worker # [ 21.785779] r3f1wmjw38qyj7k7bb5318l2khs55fsz-tribuchet-agent-1[998]: 2026-08-01T11:07:57.779532Z INFO tribuchet::worker::agent: agent listening uid=9952320worker # [ 21.792197] systemd[1]: Started tribuchet-agent-2.service.2321worker # [ 21.814087] z50xvqfac2hiya59i3rwg9zlzw6wd2d8-tribuchet-agent-2[1003]: 2026-08-01T11:07:57.819441Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=655362322hub # [ 25.135656] headscale-start[919]: 2026-08-01T11:07:58Z INF http request bytes=0 elapsed=485.451642 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:56202 status=2002323worker # [ 21.821369] z50xvqfac2hiya59i3rwg9zlzw6wd2d8-tribuchet-agent-2[1003]: 2026-08-01T11:07:57.825137Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2324worker # [ 21.826916] z50xvqfac2hiya59i3rwg9zlzw6wd2d8-tribuchet-agent-2[1003]: 2026-08-01T11:07:57.825187Z INFO tribuchet::worker::agent: agent listening uid=9942325worker # [ 21.832594] systemd[1]: Started tribuchet-agent-3.service.2326worker # [ 21.857083] qzj6j79i783pjvbdhcp3h6wj5cfz1axk-tribuchet-agent-3[1008]: 2026-08-01T11:07:57.862434Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325531136 uid_count=655362327worker # [ 21.863393] qzj6j79i783pjvbdhcp3h6wj5cfz1axk-tribuchet-agent-3[1008]: 2026-08-01T11:07:57.868899Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2328worker # [ 21.870252] qzj6j79i783pjvbdhcp3h6wj5cfz1axk-tribuchet-agent-3[1008]: 2026-08-01T11:07:57.868943Z INFO tribuchet::worker::agent: agent listening uid=9932329worker # [ 21.879132] systemd[1]: Started tribuchet-agent-4.service.2330worker # [ 21.902265] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1013]: 2026-08-01T11:07:57.907600Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325596672 uid_count=655362331worker # [ 21.908344] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1013]: 2026-08-01T11:07:57.913657Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2332worker # [ 21.915284] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1013]: 2026-08-01T11:07:57.913698Z INFO tribuchet::worker::agent: agent listening uid=9922333hub # [ 25.257598] tailscaled[613]: magicsock: disco: node [NLOJc] d:429241286b6334d9 now using 192.168.1.2:41641 mtu=1360 tx=0283c77ffd6e2334worker # [ 21.980855] tailscaled[606]: netmap: suggested exit node: ()2335worker # [ 21.984204] tailscaled[606]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2336worker # [ 21.987661] tailscaled[606]: netmap: suggested exit node: ()2337hub # [ 25.310978] tribuchet[1115]: 2026-08-01T11:07:58.529416Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }]2338worker # [ 22.033500] tribuchet[995]: 2026-08-01T11:07:58.038370Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"]2339worker # [ 22.417241] tailscaled[606]: bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2340worker # [ 22.428248] tailscaled[606]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ...2341worker # [ 22.435625] tailscaled[606]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable2342worker # [ 22.447810] tailscaled[606]: trying bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" ...2343hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.15 seconds)2344subtest: a build dispatches over the tailnet2345hub: must succeed: echo tailscale-auth-payload > /root/payload2346hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.02 seconds)2347hub: must succeed: nix-store --add /root/payload2348hub: (finished: must succeed: nix-store --add /root/payload, in 0.12 seconds)2349hub: must succeed: cat > /root/test.nix << 'EOF'2350let2351 bash = builtins.storePath "/nix/store/dddwfz7nph37q3cjky9lhpy9kb90rrrx-bash-interactive-5.3p15";2352 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2353in derivation {2354 name = "tt-tailscale";2355 system = "x86_64-linux";2356 builder = bash + "/bin/bash";2357 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2358}2359EOF2360hub: (finished: must succeed: cat > /root/test.nix << 'EOF'2361let2362 bash = builtins.storePath "/nix/store/dddwfz7nph37q3cjky9lhpy9kb90rrrx-bash-interactive-5.3p15";2363 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2364in derivation {2365 name = "tt-tailscale";2366 system = "x86_64-linux";2367 builder = bash + "/bin/bash";2368 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2369}2370EOF, in 0.03 seconds)2371hub: must succeed: nix-build /root/test.nix --no-out-link2372hub # this derivation will be built:2373hub # /nix/store/ram7vwkcrvkgfhwdk4y68xb79mzd1xmq-tt-tailscale.drv2374hub # building '/nix/store/ram7vwkcrvkgfhwdk4y68xb79mzd1xmq-tt-tailscale.drv'...2375hub # [ 26.698500] tribuchet[1115]: 2026-08-01T11:07:59.916362Z INFO tribuchet::hub::submit: queueing build id="3a8e3486168e67b9ea73413b6b952d44" system="x86_64-linux"2376hub # [ 26.704336] tribuchet[1115]: 2026-08-01T11:07:59.916686Z INFO tribuchet::hub: dispatching build id="3a8e3486168e67b9ea73413b6b952d44" worker="tt-worker"2377hub # tribuchet: building on tt-worker2378worker # [ 23.403775] tribuchet[995]: 2026-08-01T11:07:59.402680Z INFO tribuchet::worker: build assigned id="3a8e3486168e67b9ea73413b6b952d44"2379worker # [ 23.418843] systemd[1]: Started Nix Daemon.2380worker # [ 23.483402] nix-daemon[1018]: accepted connection from pid 995, user tribuchet (trusted)2381hub # [ 26.808929] tribuchet[1115]: 2026-08-01T11:08:00.027356Z INFO tribuchet::hub::relay: input path negotiation done id="3a8e3486168e67b9ea73413b6b952d44" total=8 missing=12382hub # [ 26.820586] systemd[1]: Started Nix Daemon.2383hub # [ 26.933151] nix-daemon[1153]: accepted connection from pid 1115, user root (trusted)2384worker # [ 23.685816] tribuchet[995]: 2026-08-01T11:07:59.691113Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="3a8e3486168e67b9ea73413b6b952d44" fixed_output=false network=false net_isolation=false2385worker # [ 23.731735] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1013]: 2026-08-01T11:07:59.733980Z INFO tribuchet::worker::agent: builder started id="3a8e3486168e67b9ea73413b6b952d44" pid=10252386worker # [ 23.742363] tribuchet[995]: 2026-08-01T11:07:59.734093Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="3a8e3486168e67b9ea73413b6b952d44" pid=1025 agent=/run/tribuchet/agents/4.sock scratch=/var/lib/tribuchet-agent-4/3a8e3486168e67b9ea73413b6b952d44/build2387worker # [ 23.762309] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1013]: 2026-08-01T11:07:59.767957Z INFO tribuchet::worker::agent: builder exited code=02388worker # [ 23.929747] tribuchet[995]: 2026-08-01T11:07:59.935022Z INFO tribuchet::worker::build::agent_exec: builder finished id="3a8e3486168e67b9ea73413b6b952d44" exit_code=0 aborted=None2389worker # [ 23.965546] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1013]: 2026-08-01T11:07:59.970914Z INFO tribuchet::worker::agent: cleanup done id="3a8e3486168e67b9ea73413b6b952d44"2390worker # [ 23.983507] systemd[1]: tribuchet-agent-4.service: Deactivated successfully.2391worker # [ 24.248884] tribuchet[995]: 2026-08-01T11:08:00.252885Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="3a8e3486168e67b9ea73413b6b952d44"2392worker # [ 24.276648] tribuchet[995]: 2026-08-01T11:08:00.281464Z INFO tribuchet::worker::resume: build result acknowledged id="3a8e3486168e67b9ea73413b6b952d44"2393hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 1.23 seconds)2394hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/9qvl9jmir81qmjij0p48h26vmh4cnwws-tt-tailscale2395hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/9qvl9jmir81qmjij0p48h26vmh4cnwws-tt-tailscale, in 0.04 seconds)2396hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build'2397hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.03 seconds)2398worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished'2399worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.01 seconds)2400(finished: subtest: a build dispatches over the tailnet, in 1.49 seconds)2401subtest: a non-tailnet peer is rejected2402worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml2403worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.01 seconds)2404worker: must succeed: systemctl restart tribuchet-worker2405worker # [ 24.414886] tribuchet[995]: 2026-08-01T11:08:00.419130Z INFO tribuchet::worker: handover requested; exiting2406worker # [ 24.419561] systemd[1]: Stopping tribuchet-worker.service...2407worker # [ 24.424135] systemd[1]: tribuchet-worker.service: Deactivated successfully.2408hub # [ 27.739386] tribuchet[1115]: 2026-08-01T11:08:00.957119Z INFO tribuchet::hub: worker disconnected worker="tt-worker"2409worker # [ 24.426266] systemd[1]: Stopped tribuchet-worker.service.2410worker # [ 24.427862] systemd[1]: tribuchet-worker.service: Consumed 55ms CPU time over 2.758s wall clock time, 19.8M memory peak, 17.3M read from disk, 4K written to disk, 3K incoming IP traffic, 2K outgoing IP traffic.2411worker # [ 24.438615] systemd[1]: Starting tribuchet-worker.service...2412hub # [ 27.777773] tailscaled[613]: bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2413worker # [ 24.461354] tribuchet[1053]: 2026-08-01T11:08:00.464674Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: ["/run/tribuchet/agents/1.sock", "/run/tribuchet/agents/2.sock", "/run/tribuchet/agents/3.sock", "/run/tribuchet/agents/4.sock"], spawn_agents: 0, agent_uid_base: None }2414hub # [ 27.788142] tailscaled[613]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ...2415worker # [ 24.475786] tribuchet[1053]: 2026-08-01T11:08:00.465206Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/48czgycdvysxqlbgi6rgvx9cl4kl8mml-busybox-1.37.0/bin/busybox")2416worker # [ 24.481873] systemd[1]: Started tribuchet-worker.service.2417worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.08 seconds)2418hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed'2419hub # [ 27.796203] tailscaled[613]: 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 unreachable2420worker # [ 24.488991] systemd[1]: Started tribuchet-agent-4.service.2421hub # [ 27.805318] tailscaled[613]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ...2422worker # [ 24.510537] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1059]: 2026-08-01T11:08:00.515462Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325596672 uid_count=655362423worker # [ 24.515674] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1059]: 2026-08-01T11:08:00.515790Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2424worker # [ 24.520823] jylmiyd5n02mjjmv5c0q2hggj9yzgbmj-tribuchet-agent-4[1059]: 2026-08-01T11:08:00.515822Z INFO tribuchet::worker::agent: agent listening uid=9922425hub # [ 28.211197] tribuchet[1115]: 2026-08-01T11:08:01.429235Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:577342426worker # [ 24.909651] tribuchet[1053]: 2026-08-01T11:08:00.915051Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2427worker # [ 24.920791] tribuchet[1053]: 2026-08-01T11:08:00.915144Z INFO tribuchet::worker: reconnecting to hub in 1s2428worker # [ 25.459345] tailscaled[606]: bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2429worker # [ 25.469820] tailscaled[606]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ...2430worker # [ 25.478244] tailscaled[606]: bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 46.101.74.201:443: connect: network is unreachable2431worker # [ 25.491140] tailscaled[606]: trying bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" ...2432hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.12 seconds)2433(finished: subtest: a non-tailnet peer is rejected, in 1.21 seconds)2434(finished: run the VM test script, in 30.06 seconds)2435test script finished in 30.15s2436cleanup2437kill QemuMachine (pid 47)2438hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/rgnappqqc5vbq60gza5fflyk84sylwl6-python3-3.14.6/bin/python3.14)2439kill QemuMachine (pid 48)2440worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/rgnappqqc5vbq60gza5fflyk84sylwl6-python3-3.14.6/bin/python3.14)2441(finished: cleanup, in 0.37 seconds)2442additionally exposed symbols:2443 hub, worker,2444 vlan1,2445 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