vm-test-run-tribuchet-tailscale
x86_64-linux.nixos-test-tailscale
· build #118
· 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.nNqjuUqCaJ', 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: 9d58db14-b94d-4020-b2e3-aa6a859fd35717hub # 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)... ok[ 0.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 UTC 202641hub # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/zgzkwzc0py7zqi6y54rgz8qp7jlgacvz-nixos-system-hub-test/init regInfo=/nix/store/4xprr052amsm82r31ix5dy0aj4vh4y8x-closure-info/registration console=ttyS0,115200n8 console=tty042hub # [ 0.000000] BIOS-provided physical RAM map:43hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable44hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved45hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved46hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable47hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved48hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved49hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved50hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved51hub # [ 0.000000] NX (Execute Disable) protection: active52hub # [ 0.000000] APIC: Static calls initialized53hub # [ 0.000000] SMBIOS 2.8 present.54hub # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201455hub # [ 0.000000] DMI: Memory slots populated: 1/156hub # [ 0.000000] Hypervisor detected: KVM57hub # [ 0.000000] last_pfn = 0x7ffdb max_arch_pfn = 0x1000000000058hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0059hub # [ 0.000000] kvm-clock: using sched offset of 483150046 cycles60hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns61hub # [ 0.000005] tsc: Detected 2400.018 MHz processor62hub # [ 0.000814] last_pfn = 0x7ffdb max_arch_pfn = 0x1000000000063hub # [ 0.000850] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs64hub # [ 0.000853] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT65hub # [ 0.002763] found SMP MP-table at [mem 0x000f5470-0x000f547f]66hub # [ 0.002774] Using GB pages for direct mapping67hub # [ 0.002886] RAMDISK: [mem 0x7e302000-0x7ffcffff]68hub # [ 0.002894] ACPI: Early table checksum verification disabled69hub # [ 0.002896] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )70hub # [ 0.002900] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)71hub # [ 0.002904] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)72hub # [ 0.002911] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)73hub # [ 0.002913] ACPI: FACS 0x000000007FFE0000 00004074hub # [ 0.002914] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)75hub # [ 0.002916] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)76hub # [ 0.002917] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)77hub # [ 0.002919] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]78hub # [ 0.002920] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]79hub # [ 0.002920] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]80hub # [ 0.002921] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]81hub # [ 0.002921] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]82hub # [ 0.002922] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]83hub # [ 0.003391] No NUMA configuration found84hub # [ 0.003393] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff]85hub # [ 0.003396] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff]86hub # [ 0.005682] Zone ranges:87hub # [ 0.005683] DMA [mem 0x0000000000001000-0x0000000000ffffff]88hub # [ 0.005685] DMA32 [mem 0x0000000001000000-0x000000007ffdafff]89hub # [ 0.005686] Normal empty90hub # [ 0.005686] Device empty91hub # [ 0.005687] Movable zone start for each node92hub # [ 0.005688] Early memory node ranges93hub # [ 0.005688] node 0: [mem 0x0000000000001000-0x000000000009efff]94hub # [ 0.005689] node 0: [mem 0x0000000000100000-0x000000007ffdafff]95hub # [ 0.005690] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff]96hub # [ 0.005710] On node 0, zone DMA: 1 pages in unavailable ranges97hub # [ 0.005975] On node 0, zone DMA: 97 pages in unavailable ranges98hub # [ 0.041732] On node 0, zone DMA32: 37 pages in unavailable ranges99hub # [ 0.042713] ACPI: PM-Timer IO Port: 0x608100hub # [ 0.042728] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])101hub # [ 0.042761] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23102hub # [ 0.042764] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)103hub # [ 0.042766] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)104hub # [ 0.042767] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)105hub # [ 0.042768] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)106hub # [ 0.042768] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)107hub # [ 0.042771] ACPI: Using ACPI (MADT) for SMP configuration information108hub # [ 0.042772] ACPI: HPET id: 0x8086a201 base: 0xfed00000109hub # [ 0.042777] TSC deadline timer available110hub # [ 0.042781] CPU topo: Max. logical packages: 1111hub # [ 0.042782] CPU topo: Max. logical dies: 1112hub # [ 0.042782] CPU topo: Max. dies per package: 1113hub # [ 0.042786] CPU topo: Max. threads per core: 1114hub # [ 0.042786] CPU topo: Num. cores per package: 1115hub # [ 0.042786] CPU topo: Num. threads per package: 1116hub # [ 0.042787] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs117hub # [ 0.042808] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()118hub # [ 0.042846] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]119hub # [ 0.042847] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]120hub # [ 0.042849] [mem 0x80000000-0xfeffbfff] available for PCI devices121hub # [ 0.042850] Booting paravirtualized kernel on KVM122hub # [ 0.042853] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns123hub # [ 0.047292] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1124hub # [ 0.049492] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152125hub # [ 0.049539] kvm-guest: PV spinlocks disabled, single CPU126hub # [ 0.049540] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/zgzkwzc0py7zqi6y54rgz8qp7jlgacvz-nixos-system-hub-test/init regInfo=/nix/store/4xprr052amsm82r31ix5dy0aj4vh4y8x-closure-info/registration console=ttyS0,115200n8 console=tty0127hub # [ 0.049634] Unknown kernel command line parameters "regInfo=/nix/store/4xprr052amsm82r31ix5dy0aj4vh4y8x-closure-info/registration", will be passed to user space.128hub # [ 0.049647] random: crng init done129hub # [ 0.049647] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes130hub # [ 0.051808] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)131hub # [ 0.051830] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)132hub # [ 0.051861] Fallback order for Node 0: 0133hub # [ 0.051864] Built 1 zonelists, mobility grouping on. Total pages: 524153134hub # [ 0.051864] Policy zone: DMA32135hub # [ 0.054568] mem auto-init: stack:all(zero), heap alloc:on, heap free:off136hub # [ 0.058190] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1137hub # [ 0.062657] allocated 4194304 bytes of page_ext138hub # [ 0.072161] ftrace: allocating 48598 entries in 192 pages139hub # [ 0.072163] ftrace: allocated 192 pages with 2 groups140hub # [ 0.072990] Dynamic Preempt: lazy141hub # [ 0.073134] rcu: Preemptible hierarchical RCU implementation.142hub # [ 0.073134] rcu: RCU event tracing is enabled.143hub # [ 0.073135] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.144hub # [ 0.073137] Trampoline variant of Tasks RCU enabled.145hub # [ 0.073137] Rude variant of Tasks RCU enabled.146hub # [ 0.073137] Tracing variant of Tasks RCU enabled.147hub # [ 0.073138] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.148hub # [ 0.073139] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1149hub # [ 0.073161] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.150hub # [ 0.073162] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.151hub # [ 0.073163] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.152hub # [ 0.077668] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16153hub # [ 0.077940] rcu: srcu_init: Setting srcu_struct sizes based on contention.154hub # [ 0.078051] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)155hub # [ 0.085186] Console: colour VGA+ 80x25156hub # [ 0.085190] printk: legacy console [tty0] enabled157hub # [ 0.125454] printk: legacy console [ttyS0] enabled158hub # [ 0.308856] ACPI: Core revision 20250807159hub # [ 0.310365] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns160hub # [ 0.313247] APIC: Switch to symmetric I/O mode setup161hub # [ 0.314981] x2apic enabled162hub # [ 0.316191] APIC: Switched APIC routing to: physical x2apic163hub # [ 0.319008] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1164hub # [ 0.320811] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns165hub # [ 0.323875] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018)166hub # [ 0.326000] x86/cpu: User Mode Instruction Prevention (UMIP) activated167hub # [ 0.327024] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127168hub # [ 0.327874] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0169hub # [ 0.328878] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto170hub # [ 0.330874] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl171hub # [ 0.331875] Transient Scheduler Attacks: Mitigation: Clear CPU buffers172hub # [ 0.333875] Spectre V2 : Mitigation: Enhanced / Automatic IBRS173hub # [ 0.334874] Speculative Return Stack Overflow: Mitigation: Safe RET174hub # [ 0.335874] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization175hub # [ 0.336880] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier176hub # [ 0.337875] active return thunk: srso_alias_return_thunk177hub # [ 0.339891] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'178hub # [ 0.340874] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'179hub # [ 0.341874] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'180hub # [ 0.343874] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'181hub # [ 0.345874] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'182hub # [ 0.346874] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'183hub # [ 0.347874] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'184hub # [ 0.348874] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'185hub # [ 0.350874] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'186hub # [ 0.352874] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256187hub # [ 0.353874] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64188hub # [ 0.354874] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512189hub # [ 0.356874] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024190hub # [ 0.358874] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8191hub # [ 0.359874] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16192hub # [ 0.360874] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24193hub # [ 0.361874] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.194hub # [ 0.397473] Freeing SMP alternatives memory: 44K195hub # [ 0.397877] pid_max: default: 32768 minimum: 301196hub # [ 0.398982] LSM: initializing lsm=capability,landlock,yama,bpf,ima197hub # [ 0.399977] landlock: Up and running.198hub # [ 0.400874] Yama: becoming mindful.199hub # [ 0.402086] LSM support for eBPF active200hub # [ 0.404014] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)201hub # [ 0.404915] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)202hub # [ 0.407610] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)203hub # [ 0.408388] Performance Events: Fam17h+ core perfctr, AMD PMU driver.204hub # [ 0.408879] ... version: 2205hub # [ 0.409876] ... bit width: 48206hub # [ 0.410928] ... generic counters: 6207hub # [ 0.411876] ... generic bitmap: 000000000000003f208hub # [ 0.412876] ... fixed-purpose counters: 0209hub # [ 0.413875] ... fixed-purpose bitmap: 0000000000000000210hub # [ 0.414876] ... value mask: 0000ffffffffffff211hub # [ 0.415876] ... max period: 00007fffffffffff212hub # [ 0.416876] ... global_ctrl mask: 000000000000003f213hub # [ 0.418016] signal: max sigframe size: 3376214hub # [ 0.418979] rcu: Hierarchical SRCU implementation.215hub # [ 0.419880] rcu: Max phase no-delay instances is 400.216hub # [ 0.425497] smp: Bringing up secondary CPUs ...217hub # [ 0.425892] smp: Brought up 1 node, 1 CPU218hub # [ 0.426878] smpboot: Total of 1 processors activated (4800.03 BogoMIPS)219hub # [ 0.428102] Memory: 1969264K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved)220hub # [ 0.429191] devtmpfs: initialized221hub # [ 0.430137] x86/mm: Memory block size: 128MB222hub # [ 0.432023] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns223hub # [ 0.432908] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)224hub # [ 0.433904] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).225hub # [ 0.434972] pinctrl core: initialized pinctrl subsystem226hub # [ 0.436184] PM: RTC time: 09:39:53, date: 2026-07-13227hub # [ 0.439611] NET: Registered PF_NETLINK/PF_ROUTE protocol family228hub # [ 0.441420] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations229hub # [ 0.441902] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations230hub # [ 0.443155] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations231hub # [ 0.443887] audit: initializing netlink subsys (disabled)232hub # [ 0.445134] thermal_sys: Registered thermal governor 'fair_share'233hub # [ 0.445136] thermal_sys: Registered thermal governor 'bang_bang'234hub # [ 0.445879] audit: type=2000 audit(1783935594.176:1): state=initialized audit_enabled=0 res=1235hub # [ 0.447879] thermal_sys: Registered thermal governor 'step_wise'236hub # [ 0.447881] thermal_sys: Registered thermal governor 'user_space'237hub # [ 0.448876] thermal_sys: Registered thermal governor 'power_allocator'238hub # [ 0.449927] cpuidle: using governor menu239hub # [ 0.453027] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5240hub # [ 0.454159] PCI: Using configuration type 1 for base access241hub # [ 0.454876] PCI: Using configuration type 1 for extended access242hub # [ 0.456076] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.243hub # [ 0.462894] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages244hub # [ 0.463877] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page245hub # [ 0.468875] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages246hub # [ 0.469877] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page247hub # [ 0.481155] ACPI: Added _OSI(Module Device)248hub # [ 0.481877] ACPI: Added _OSI(Processor Device)249hub # [ 0.483913] ACPI: Added _OSI(Processor Aggregator Device)250hub # [ 0.488721] ACPI: 1 ACPI AML tables successfully acquired and loaded251hub # [ 0.495116] ACPI: Interpreter enabled252hub # [ 0.495894] ACPI: PM: (supports S0 S3 S4 S5)253hub # [ 0.496877] ACPI: Using IOAPIC for interrupt routing254hub # [ 0.497906] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug255hub # [ 0.500875] PCI: Using E820 reservations for host bridge windows256hub # [ 0.502024] ACPI: Enabled 2 GPEs in block 00 to 0F257hub # [ 0.510166] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])258hub # [ 0.510883] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]259hub # [ 0.512252] acpiphp: Slot [3] registered260hub # [ 0.512919] acpiphp: Slot [4] registered261hub # [ 0.513930] acpiphp: Slot [5] registered262hub # [ 0.514917] acpiphp: Slot [6] registered263hub # [ 0.515916] acpiphp: Slot [7] registered264hub # [ 0.516934] acpiphp: Slot [8] registered265hub # [ 0.517981] acpiphp: Slot [9] registered266hub # [ 0.518931] acpiphp: Slot [10] registered267hub # [ 0.519918] acpiphp: Slot [11] registered268hub # [ 0.520937] acpiphp: Slot [12] registered269hub # [ 0.521919] acpiphp: Slot [13] registered270hub # [ 0.522908] acpiphp: Slot [14] registered271hub # [ 0.523908] acpiphp: Slot [15] registered272hub # [ 0.524922] acpiphp: Slot [16] registered273hub # [ 0.525909] acpiphp: Slot [17] registered274hub # [ 0.526908] acpiphp: Slot [18] registered275hub # [ 0.527908] acpiphp: Slot [19] registered276hub # [ 0.528921] acpiphp: Slot [20] registered277hub # [ 0.529908] acpiphp: Slot [21] registered278hub # [ 0.530908] acpiphp: Slot [22] registered279hub # [ 0.531908] acpiphp: Slot [23] registered280hub # [ 0.532925] acpiphp: Slot [24] registered281hub # [ 0.533934] acpiphp: Slot [25] registered282hub # [ 0.534908] acpiphp: Slot [26] registered283hub # [ 0.535923] acpiphp: Slot [27] registered284hub # [ 0.536910] acpiphp: Slot [28] registered285hub # [ 0.537932] acpiphp: Slot [29] registered286hub # [ 0.538923] acpiphp: Slot [30] registered287hub # [ 0.539922] acpiphp: Slot [31] registered288hub # [ 0.540900] PCI host bridge to bus 0000:00289hub # [ 0.541883] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]290hub # [ 0.542876] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]291hub # [ 0.543877] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]292hub # [ 0.544877] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]293hub # [ 0.545885] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]294hub # [ 0.546877] pci_bus 0000:00: root bus resource [bus 00-ff]295hub # [ 0.548192] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint296hub # [ 0.549760] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint297hub # [ 0.551779] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint298hub # [ 0.554716] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]299hub # [ 0.555940] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk300hub # [ 0.556876] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk301hub # [ 0.557876] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk302hub # [ 0.558876] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk303hub # [ 0.560296] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint304hub # [ 0.561941] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]305hub # [ 0.564115] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint306hub # [ 0.565496] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI307hub # [ 0.566891] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB308hub # [ 0.568293] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint309hub # [ 0.570952] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]310hub # [ 0.571906] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]311hub # [ 0.572935] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]312hub # [ 0.574140] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]313hub # [ 0.576133] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint314hub # [ 0.578912] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]315hub # [ 0.579891] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]316hub # [ 0.580928] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]317hub # [ 0.581890] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]318hub # [ 0.585045] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint319hub # [ 0.587913] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]320hub # [ 0.588890] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]321hub # [ 0.589928] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]322hub # [ 0.592939] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint323hub # [ 0.595804] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]324hub # [ 0.596890] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]325hub # [ 0.597928] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]326hub # [ 0.600876] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint327hub # [ 0.603911] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]328hub # [ 0.605891] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]329hub # [ 0.606928] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]330hub # [ 0.609902] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint331hub # [ 0.612914] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]332hub # [ 0.613890] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]333hub # [ 0.614940] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]334hub # [ 0.617902] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint335hub # [ 0.620968] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]336hub # [ 0.621942] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]337hub # [ 0.622927] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]338hub # [ 0.626601] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint339hub # [ 0.629876] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]340hub # [ 0.630891] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]341hub # [ 0.631939] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]342hub # [ 0.632891] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]343hub # [ 0.635849] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint344hub # [ 0.637903] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]345hub # [ 0.638928] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]346hub # [ 0.641828] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint347hub # [ 0.644922] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]348hub # [ 0.645890] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]349hub # [ 0.646928] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]350hub # [ 0.649889] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint351hub # [ 0.652877] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]352hub # [ 0.653891] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]353hub # [ 0.654928] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]354hub # [ 0.663252] ACPI: PCI: Interrupt link LNKA configured for IRQ 10355hub # [ 0.664084] ACPI: PCI: Interrupt link LNKB configured for IRQ 10356hub # [ 0.665065] ACPI: PCI: Interrupt link LNKC configured for IRQ 11357hub # [ 0.666068] ACPI: PCI: Interrupt link LNKD configured for IRQ 11358hub # [ 0.666981] ACPI: PCI: Interrupt link LNKS configured for IRQ 9359hub # [ 0.669183] iommu: Default domain type: Translated360hub # [ 0.669886] iommu: DMA domain TLB invalidation policy: lazy mode361hub # [ 0.671162] ACPI: bus type USB registered362hub # [ 0.671932] usbcore: registered new interface driver usbfs363hub # [ 0.672907] usbcore: registered new interface driver hub364hub # [ 0.673887] usbcore: registered new device driver usb365hub # [ 0.675828] NetLabel: Initializing366hub # [ 0.676676] NetLabel: domain hash size = 128367hub # [ 0.677875] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO368hub # [ 0.678917] NetLabel: unlabeled traffic allowed by default369hub # [ 0.679891] PCI: Using ACPI for IRQ routing370hub # [ 0.681551] pci 0000:00:02.0: vgaarb: setting as boot VGA device371hub # [ 0.681871] pci 0000:00:02.0: vgaarb: bridge control possible372hub # [ 0.681871] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none373hub # [ 0.681877] vgaarb: loaded374hub # [ 0.683013] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0375hub # [ 0.683875] hpet0: 3 comparators, 64-bit 100.000000 MHz counter376hub # [ 0.687961] clocksource: Switched to clocksource kvm-clock377hub # [ 0.692071] VFS: Disk quotas dquot_6.6.0378hub # [ 0.693331] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)379hub # [ 0.695541] pnp: PnP ACPI init380hub # [ 0.697213] pnp: PnP ACPI: found 6 devices381hub # [ 0.705385] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns382hub # [ 0.707913] clocksource: Switched to clocksource acpi_pm383hub # [ 0.709663] NET: Registered PF_INET protocol family384hub # [ 0.711520] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)385hub # [ 0.729433] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)386hub # [ 0.732100] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)387hub # [ 0.734379] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)388hub # [ 0.736719] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)389hub # [ 0.738971] TCP: Hash tables configured (established 16384 bind 16384)390hub # [ 0.740983] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)391hub # [ 0.743190] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)392hub # [ 0.745139] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)393hub # [ 0.747256] NET: Registered PF_UNIX/PF_LOCAL protocol family394hub # [ 0.748985] NET: Registered PF_XDP protocol family395hub # [ 0.750475] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]396hub # [ 0.752289] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]397hub # [ 0.754098] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]398hub # [ 0.756088] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]399hub # [ 0.758077] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]400hub # [ 0.760203] pci 0000:00:01.0: PIIX3: Enabling Passive Release401hub # [ 0.761965] pci 0000:00:00.0: Limiting direct PCI/PCI transfers402hub # [ 0.765278] ACPI: \_SB_.LNKD: Enabled at IRQ 11403hub # [ 0.768614] PCI: CLS 0 bytes, default 64404hub # [ 0.770179] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns405hub # [ 0.773118] Trying to unpack rootfs image as initramfs...406hub # [ 0.820228] Initialise system trusted keyrings407hub # [ 0.825017] workingset: timestamp_bits=40 max_order=19 bucket_order=0408hub # [ 0.850275] Key type asymmetric registered409hub # [ 0.851567] Asymmetric key parser 'x509' registered410hub # [ 0.857031] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)411hub # [ 0.862037] io scheduler mq-deadline registered412hub # [ 0.864975] io scheduler kyber registered413hub # [ 0.868576] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled414hub # [ 0.870799] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A415hub # [ 0.879576] Linux agpgart interface v0.103416hub # [ 0.882983] ACPI: bus type drm_connector registered417hub # [ 0.887186] usbcore: registered new interface driver usbserial_generic418hub # [ 0.889098] usbserial: USB Serial support registered for generic419hub # [ 0.894980] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.420hub # [ 0.894980] Please enable it if your BIOS has the CPPC option.421hub # [ 0.898875] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled422hub # [ 0.906123] drop_monitor: Initializing network drop monitor service423hub # [ 0.908093] NET: Registered PF_INET6 protocol family424hub # [ 0.913553] Segment Routing with IPv6425hub # [ 0.917996] In-situ OAM (IOAM) with IPv6426hub # [ 0.919635] IPI shorthand broadcast: enabled427hub # [ 0.928303] sched_clock: Marking stable (689031784, 238922866)->(1120193108, -192238458)428hub # [ 0.935122] registered taskstats version 1429hub # [ 0.936666] Loading compiled-in X.509 certificates430hub # [ 0.958578] Demotion targets for Node 0: null431hub # [ 0.962033] Key type .fscrypt registered432hub # [ 0.965980] Key type fscrypt-provisioning registered433hub # [ 0.967734] ima: No TPM chip found, activating TPM-bypass!434hub # [ 0.970973] ima: Allocated hash algorithm: sha1435hub # [ 0.972415] ima: No architecture policies found436hub # [ 0.978160] PM: Magic number: 2:70:677437hub # [ 0.982363] RAS: Correctable Errors collector initialized.438hub # [ 0.991818] clk: Disabling unused clocks439hub # [ 0.996976] PM: genpd: Disabling unused power domains440hub # [ 1.138720] Freeing initrd memory: 29496K441hub # [ 1.142632] Freeing unused decrypted memory: 2028K442hub # [ 1.146013] Freeing unused kernel image (initmem) memory: 3636K443hub # [ 1.147874] Write protecting the kernel read-only data: 32768k444hub # [ 1.150605] Freeing unused kernel image (text/rodata gap) memory: 1272K445hub # [ 1.153057] Freeing unused kernel image (rodata/data gap) memory: 796K446hub # [ 1.206061] x86/mm: Checked W+X mappings: passed, no W+X pages found.447hub # [ 1.208013] Run /init as init process448hub # [ 1.219473] systemd[1]: Inserted module 'autofs4'449hub # [ 1.236383] fuse: init (API version 7.45)450hub # [ 1.243769] ACPI: \_SB_.LNKC: Enabled at IRQ 10451hub # [ 1.252626] ACPI: \_SB_.LNKA: Enabled at IRQ 10452hub # [ 1.257080] ACPI: \_SB_.LNKB: Enabled at IRQ 11453hub # [ 1.301986] systemd[1]: Successfully made /usr/ read-only.454hub # [ 1.641294] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)455hub # [ 1.662485] systemd[1]: Detected virtualization kvm.456hub # [ 1.666417] systemd[1]: Detected architecture x86-64.457hub # [ 1.670370] systemd[1]: Running in initrd.458hub # [ 1.674575] systemd[1]: Initializing machine ID from random generator.459hub # [ 1.679637] systemd[1]: Hostname set to <hub>.460hub # [ 1.901472] systemd[1]: bpf-restrict-fs: LSM BPF program attached461hub # [ 1.961558] systemd[1]: Queued start job for default target Initrd Default Target.462hub # [ 1.966584] systemd[1]: Created slice Slice /system/modprobe.463hub # [ 1.968633] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.464hub # [ 1.971082] systemd[1]: Expecting device /dev/disk/by-label/nixos...465hub # [ 1.973127] systemd[1]: Reached target Path Units.466hub # [ 1.974680] systemd[1]: Reached target Slice Units.467hub # [ 1.976313] systemd[1]: Reached target Swaps.468hub # [ 1.977743] systemd[1]: Reached target Timer Units.469hub # [ 1.979488] systemd[1]: Listening on D-Bus System Message Bus Socket.470hub # [ 1.981612] systemd[1]: Listening on Journal Socket (/dev/log).471hub # [ 1.983659] systemd[1]: Listening on Journal Sockets.472hub # [ 1.985446] systemd[1]: Listening on udev Control Socket.473hub # [ 1.987258] systemd[1]: Listening on udev Kernel Socket.474hub # [ 1.988969] systemd[1]: Reached target Socket Units.475hub # [ 1.991674] systemd[1]: Starting Create List of Static Device Nodes...476hub # [ 1.998088] systemd[1]: Starting Load Kernel Module 9pnet_virtio...477hub # [ 2.009053] systemd[1]: Starting Load Kernel Module configfs...478hub # [ 2.021049] systemd[1]: Starting Journal Service...479hub # [ 2.038050] systemd[1]: Starting Load Kernel Modules...480hub # [ 2.045877] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os481hub # [ 2.061390] netfs: FS-Cache loaded482hub # [ 2.068742] 9pnet: Installing 9P2000 support483hub # [ 2.093187] systemd[1]: Starting Coldplug All udev Devices...484hub # [ 2.100773] systemd-journald[67]: Collecting audit messages is disabled.485hub # [ 2.106973] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.486hub # [ 2.114047] systemd[1]: Finished Create List of Static Device Nodes.487hub # [ 2.117740] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.488hub # [ 2.122106] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev489hub # [ 2.132865] systemd[1]: Finished Load Kernel Module 9pnet_virtio.490hub # [ 2.142509] systemd[1]: modprobe@configfs.service: Deactivated successfully.491hub # [ 2.154465] systemd[1]: Finished Load Kernel Module configfs.492hub # [ 2.163077] systemd[1]: Finished Load Kernel Modules.493hub # [ 2.168759] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config494hub # [ 2.183204] systemd[1]: Starting Apply Kernel Variables...495hub # [ 2.203093] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...496hub # [ 2.229139] systemd[1]: Finished Apply Kernel Variables.497hub # [ 2.243104] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.498hub # [ 2.253188] systemd[1]: Starting Create Static Device Nodes in /dev...499hub # [ 2.287139] systemd[1]: Finished Create Static Device Nodes in /dev.500hub # [ 2.294686] systemd[1]: Started Journal Service.501hub # [ 2.054989] systemd-modules-load[68]: Inserted module 'dm_mod'502hub # [ 2.059883] systemd-modules-load[68]: Inserted module 'virtio_balloon'503hub # [ 2.062478] systemd-modules-load[68]: Inserted module 'virtio_gpu'504hub # [ 2.065484] systemd[1]: Reached target Preparation for Local File Systems.505hub # [ 2.070667] systemd[1]: Reached target Local File Systems.506hub # [ 2.072566] systemd[1]: Starting Create System Files and Directories...507hub # [ 2.079350] systemd[1]: Starting Rule-based Manager for Device Events and Files...508hub # [ 2.114773] systemd[1]: Finished Create System Files and Directories.509hub # [ 2.142601] systemd-udevd[76]: Using default interface naming scheme 'v261'.510hub # [ 2.178109] systemd[1]: Started Rule-based Manager for Device Events and Files.511hub # [ 2.220335] systemd[1]: Finished Coldplug All udev Devices.512hub # [ 2.223099] systemd[1]: Reached target System Initialization.513hub # [ 2.225837] systemd[1]: Reached target Basic System.514worker: QEMU running (pid 48)515worker # Disk image does not exist, creating the virtualisation disk image...516worker # Formatting '/build/vm-state-worker/tmp.Pb9vtOXyMC', fmt=raw size=1073741824517worker # mke2fs 1.47.4 (6-Mar-2025)518worker # Discarding device blocks: 0/262144 done519worker # Creating filesystem with 262144 4k blocks and 65536 inodes520(finished: start all VMs, in 3.46 seconds)521worker # Filesystem UUID: 222ce66b-4f53-48b8-af0b-d72e1bbec002522hub: waiting for unit headscale523worker # Superblock backups stored on blocks:524hub: waiting for the VM to finish booting525worker # 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.535worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)536worker # 537worker # 538worker # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1900+7EF31900 CA00539worker # Press Ctrl-B to configure iPXE (PCI 00:03.0)...540worker # 541worker # 542worker # 543worker # 544worker # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1900 7EF31900 CB00545hub # [ 2.798620] uhci_hcd 0000:00:01.2: UHCI Host Controller546worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)...547worker # 548worker # 549hub # [ 2.813286] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1550hub # [ 2.815079] uhci_hcd 0000:00:01.2: detected 2 ports551hub # [ 2.827678] SCSI subsystem initialized552hub # [ 2.829564] virtio_blk virtio5: 1/0/0 default/read/poll queues553hub # [ 2.832339] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12554worker # Booting from ROM...555hub # [ 2.842355] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100556hub # [ 2.849635] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)557hub # [ 2.851805] serio: i8042 KBD port at 0x60,0x64 irq 1558hub # [ 2.861066] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18559hub # [ 2.862956] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1560hub # [ 2.871428] serio: i8042 AUX port at 0x60,0x64 irq 12561hub # [ 2.895960] usb usb1: Product: UHCI Host Controller562hub # [ 2.661178] systemd[1]: Starting Virtual Console Setup...563hub # [ 2.915616] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd564hub # [ 2.682107] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.565hub # [ 2.689315] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.566hub # [ 2.698840] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.567hub # [ 2.707342] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.568hub # [ 2.951263] usb usb1: SerialNumber: 0000:00:01.2569hub # [ 2.714428] systemd[1]: Finished Virtual Console Setup.570hub # [ 2.956517] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0571hub # [ 2.965752] hub 1-0:1.0: USB hub found572hub # [ 2.971588] hub 1-0:1.0: 2 ports detected573hub # [ 2.761454] systemd[1]: Found device /dev/disk/by-label/nixos.574hub # [ 2.763384] systemd[1]: Reached target Initrd Root Device.575hub # [ 2.767476] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...576hub # [ 3.024873] scsi host0: ata_piix577hub # [ 3.031822] scsi host1: ata_piix578hub # [ 3.033366] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0579hub # [ 3.040747] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0580hub # [ 2.807708] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks581hub # [ 2.815383] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.582hub # [ 2.869145] systemd[1]: Mounting /sysroot...583hub # [ 3.197534] ata2: found unknown device (class 0)584worker # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 UTC 2026585hub # [ 3.201828] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100586worker # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/jfblc23in63zx144sr9kfhfhdc5fyhn9-nixos-system-worker-test/init regInfo=/nix/store/4aq57bwm439kb1kh2svs9l9f6m01m9by-closure-info/registration console=ttyS0,115200n8 console=tty0587worker # [ 0.000000] BIOS-provided physical RAM map:588worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable589hub # [ 3.206399] usb 1-1: new full-speed USB device number 2 using uhci_hcd590worker # [ 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] reserved596hub # [ 3.214361] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5597worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved598worker # [ 0.000000] NX (Execute Disable) protection: active599worker # [ 0.000000] APIC: Static calls initialized600worker # [ 0.000000] SMBIOS 2.8 present.601worker # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014602worker # [ 0.000000] DMI: Memory slots populated: 1/1603worker # [ 0.000000] Hypervisor detected: KVM604worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000605worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00606worker # [ 0.000000] kvm-clock: using sched offset of 491300564 cycles607worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns608worker # [ 0.000005] tsc: Detected 2400.018 MHz processor609worker # [ 0.000811] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000610worker # [ 0.000847] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs611worker # [ 0.000850] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT612worker # [ 0.002751] found SMP MP-table at [mem 0x000f5470-0x000f547f]613worker # [ 0.002762] Using GB pages for direct mapping614worker # [ 0.002845] RAMDISK: [mem 0x7e2fa000-0x7ffcffff]615worker # [ 0.002853] ACPI: Early table checksum verification disabled616worker # [ 0.002855] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )617worker # [ 0.002859] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)618worker # [ 0.002863] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)619worker # [ 0.002869] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)620worker # [ 0.002871] ACPI: FACS 0x000000007FFE0000 000040621worker # [ 0.002873] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)622worker # [ 0.002874] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)623worker # [ 0.002876] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)624worker # [ 0.002877] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]625worker # [ 0.002878] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]626worker # [ 0.002879] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]627worker # [ 0.002879] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]628worker # [ 0.002880] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]629worker # [ 0.002880] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]630worker # [ 0.003352] No NUMA configuration found631worker # [ 0.003353] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]632worker # [ 0.003356] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]633worker # [ 0.005643] Zone ranges:634worker # [ 0.005643] DMA [mem 0x0000000000001000-0x0000000000ffffff]635worker # [ 0.005645] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff]636worker # [ 0.005646] Normal empty637worker # [ 0.005647] Device empty638worker # [ 0.005647] Movable zone start for each node639worker # [ 0.005648] Early memory node ranges640worker # [ 0.005648] node 0: [mem 0x0000000000001000-0x000000000009efff]641hub # [ 3.279704] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray642worker # [ 0.005649] node 0: [mem 0x0000000000100000-0x000000007ffd7fff]643worker # [ 0.005650] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]644worker # [ 0.005672] On node 0, zone DMA: 1 pages in unavailable ranges645worker # [ 0.005944] On node 0, zone DMA: 97 pages in unavailable ranges646worker # [ 0.041751] On node 0, zone DMA32: 40 pages in unavailable ranges647worker # [ 0.042727] ACPI: PM-Timer IO Port: 0x608648worker # [ 0.042750] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])649worker # [ 0.042784] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23650worker # [ 0.042787] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)651worker # [ 0.042789] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)652worker # [ 0.042790] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)653worker # [ 0.042791] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)654hub # [ 3.298385] cdrom: Uniform CD-ROM driver Revision: 3.20655worker # [ 0.042792] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)656worker # [ 0.042794] ACPI: Using ACPI (MADT) for SMP configuration information657worker # [ 0.042795] ACPI: HPET id: 0x8086a201 base: 0xfed00000658worker # [ 0.042799] TSC deadline timer available659worker # [ 0.042803] CPU topo: Max. logical packages: 1660worker # [ 0.042804] CPU topo: Max. logical dies: 1661worker # [ 0.042805] CPU topo: Max. dies per package: 1662worker # [ 0.042808] CPU topo: Max. threads per core: 1663worker # [ 0.042808] CPU topo: Num. cores per package: 1664worker # [ 0.042809] CPU topo: Num. threads per package: 1665worker # [ 0.042809] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs666worker # [ 0.042831] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()667worker # [ 0.042868] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]668worker # [ 0.042870] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]669worker # [ 0.042871] [mem 0x80000000-0xfeffbfff] available for PCI devices670worker # [ 0.042873] Booting paravirtualized kernel on KVM671worker # [ 0.042876] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns672hub # [ 3.319620] EXT4-fs (vda): mounted filesystem 9d58db14-b94d-4020-b2e3-aa6a859fd357 r/w with ordered data mode. Quota mode: none.673worker # [ 0.047307] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1674worker # [ 0.049491] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152675worker # [ 0.049538] kvm-guest: PV spinlocks disabled, single CPU676hub # [ 3.086796] systemd[1]: Mounted /sysroot.677hub # [ 3.088811] systemd[1]: Reached target Initrd Root File System.678worker # [ 0.049540] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/jfblc23in63zx144sr9kfhfhdc5fyhn9-nixos-system-worker-test/init regInfo=/nix/store/4aq57bwm439kb1kh2svs9l9f6m01m9by-closure-info/registration console=ttyS0,115200n8 console=tty0679worker # [ 0.049634] Unknown kernel command line parameters "regInfo=/nix/store/4aq57bwm439kb1kh2svs9l9f6m01m9by-closure-info/registration", will be passed to user space.680hub # [ 3.096707] systemd[1]: Starting Mountpoints Configured in the Real Root...681worker # [ 0.049646] random: crng init done682worker # [ 0.049647] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes683worker # [ 0.051817] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)684worker # [ 0.051840] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)685worker # [ 0.051872] Fallback order for Node 0: 0686worker # [ 0.051874] Built 1 zonelists, mobility grouping on. Total pages: 524150687worker # [ 0.051875] Policy zone: DMA32688worker # [ 0.054501] mem auto-init: stack:all(zero), heap alloc:on, heap free:off689worker # [ 0.058096] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1690worker # [ 0.062532] allocated 4194304 bytes of page_ext691hub # [ 3.109297] systemd-sysroot-fstab-check[127]: /sysroot should be mounted in the initrd, will request daemon-reload.692worker # [ 0.072019] ftrace: allocating 48598 entries in 192 pages693worker # [ 0.072021] ftrace: allocated 192 pages with 2 groups694worker # [ 0.072845] Dynamic Preempt: lazy695worker # [ 0.072967] rcu: Preemptible hierarchical RCU implementation.696worker # [ 0.072968] rcu: RCU event tracing is enabled.697hub # [ 3.115954] systemd[1]: Reload requested from client PID 127 ('systemd-sysroot') (unit initrd-parse-etc.service)...698worker # [ 0.072968] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.699hub # [ 3.118705] systemd[1]: Reloading...700worker # [ 0.072970] Trampoline variant of Tasks RCU enabled.701worker # [ 0.072970] Rude variant of Tasks RCU enabled.702worker # [ 0.072971] Tracing variant of Tasks RCU enabled.703worker # [ 0.072971] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.704worker # [ 0.072972] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1705worker # [ 0.073022] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.706worker # [ 0.073024] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.707worker # [ 0.073025] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.708worker # [ 0.077551] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16709worker # [ 0.077821] rcu: srcu_init: Setting srcu_struct sizes based on contention.710worker # [ 0.077930] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)711worker # [ 0.085073] Console: colour VGA+ 80x25712worker # [ 0.085077] printk: legacy console [tty0] enabled713worker # [ 0.125649] printk: legacy console [ttyS0] enabled714worker # [ 0.308786] ACPI: Core revision 20250807715worker # [ 0.310303] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns716worker # [ 0.313026] APIC: Switch to symmetric I/O mode setup717worker # [ 0.314742] x2apic enabled718hub # [ 3.384240] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00719hub # [ 3.386180] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10720worker # [ 0.315957] APIC: Switched APIC routing to: physical x2apic721worker # [ 0.318789] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1722hub # [ 3.390967] usb 1-1: Product: QEMU USB Tablet723worker # [ 0.320568] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns724hub # [ 3.393486] usb 1-1: Manufacturer: QEMU725worker # [ 0.323627] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018)726hub # [ 3.395645] usb 1-1: SerialNumber: 28754-0000:00:01.2-1727worker # [ 0.325742] x86/cpu: User Mode Instruction Prevention (UMIP) activated728worker # [ 0.326789] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127729worker # [ 0.327625] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0730worker # [ 0.328629] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto731worker # [ 0.330626] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl732worker # [ 0.331625] Transient Scheduler Attacks: Mitigation: Clear CPU buffers733worker # [ 0.332625] Spectre V2 : Mitigation: Enhanced / Automatic IBRS734worker # [ 0.333625] Speculative Return Stack Overflow: Mitigation: Safe RET735worker # [ 0.334624] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization736worker # [ 0.335631] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier737worker # [ 0.337625] active return thunk: srso_alias_return_thunk738worker # [ 0.338654] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'739worker # [ 0.340624] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'740worker # [ 0.341625] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'741worker # [ 0.343625] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'742hub # [ 3.432468] hid: raw HID events driver (C) Jiri Kosina743worker # [ 0.344624] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'744worker # [ 0.345624] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'745worker # [ 0.346625] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'746worker # [ 0.347625] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'747worker # [ 0.348625] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'748worker # [ 0.350625] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256749worker # [ 0.351624] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64750worker # [ 0.353625] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512751worker # [ 0.355624] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024752worker # [ 0.356624] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8753worker # [ 0.357624] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16754worker # [ 0.358625] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24755worker # [ 0.360625] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.756hub # [ 3.461971] usbcore: registered new interface driver usbhid757hub # [ 3.470966] usbhid: USB HID core driver758hub # [ 3.487305] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2759worker # [ 0.395567] Freeing SMP alternatives memory: 44K760worker # [ 0.396626] pid_max: default: 32768 minimum: 301761hub # [ 3.493264] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0762worker # [ 0.397732] LSM: initializing lsm=capability,landlock,yama,bpf,ima763worker # [ 0.399743] landlock: Up and running.764worker # [ 0.401476] Yama: becoming mindful.765worker # [ 0.402838] LSM support for eBPF active766worker # [ 0.403734] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)767worker # [ 0.405670] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)768worker # [ 0.408725] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)769worker # [ 0.410179] Performance Events: Fam17h+ core perfctr, AMD PMU driver.770worker # [ 0.410635] ... version: 2771worker # [ 0.411626] ... bit width: 48772worker # [ 0.412626] ... generic counters: 6773worker # [ 0.413626] ... generic bitmap: 000000000000003f774worker # [ 0.414626] ... fixed-purpose counters: 0775worker # [ 0.415626] ... fixed-purpose bitmap: 0000000000000000776hub # [ 3.279776] systemd[1]: Reloading finished in 159 ms.777worker # [ 0.416626] ... value mask: 0000ffffffffffff778worker # [ 0.417626] ... max period: 00007fffffffffff779worker # [ 0.418626] ... global_ctrl mask: 000000000000003f780worker # [ 0.419744] signal: max sigframe size: 3376781worker # [ 0.420721] rcu: Hierarchical SRCU implementation.782worker # [ 0.421630] rcu: Max phase no-delay instances is 400.783hub # [ 3.291581] systemd-sysroot-fstab-check[127]: Requesting initrd-fs.target/start/replace...784worker # [ 0.427260] smp: Bringing up secondary CPUs ...785worker # [ 0.427642] smp: Brought up 1 node, 1 CPU786worker # [ 0.428629] smpboot: Total of 1 processors activated (4800.03 BogoMIPS)787hub # [ 3.298258] systemd-sysroot-fstab-check[127]: Requesting swap.target/start/replace...788worker # [ 0.429885] Memory: 1969228K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved)789worker # [ 0.430918] devtmpfs: initialized790hub # [ 3.302794] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio791worker # [ 0.431923] x86/mm: Memory block size: 128MB792hub # [ 3.306297] systemd[1]: initrd-parse-etc.service: Deactivated successfully.793worker # [ 0.433743] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns794hub # [ 3.308766] systemd[1]: Finished Mountpoints Configured in the Real Root.795worker # [ 0.434659] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)796hub # [ 3.311232] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.797worker # [ 0.435654] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).798worker # [ 0.436734] pinctrl core: initialized pinctrl subsystem799worker # [ 0.437964] PM: RTC time: 09:39:57, date: 2026-07-13800worker # [ 0.441372] NET: Registered PF_NETLINK/PF_ROUTE protocol family801worker # [ 0.443145] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations802worker # [ 0.443651] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations803worker # [ 0.444907] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations804worker # [ 0.445637] audit: initializing netlink subsys (disabled)805worker # [ 0.446893] thermal_sys: Registered thermal governor 'fair_share'806worker # [ 0.446895] thermal_sys: Registered thermal governor 'bang_bang'807worker # [ 0.447630] audit: type=2000 audit(1783935597.441:1): state=initialized audit_enabled=0 res=1808worker # [ 0.449629] thermal_sys: Registered thermal governor 'step_wise'809worker # [ 0.449631] thermal_sys: Registered thermal governor 'user_space'810worker # [ 0.450627] thermal_sys: Registered thermal governor 'power_allocator'811worker # [ 0.451648] cpuidle: using governor menu812worker # [ 0.454776] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5813worker # [ 0.455904] PCI: Using configuration type 1 for base access814worker # [ 0.456627] PCI: Using configuration type 1 for extended access815worker # [ 0.457860] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.816worker # [ 0.462912] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages817worker # [ 0.463627] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page818worker # [ 0.468626] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages819worker # [ 0.469627] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page820worker # [ 0.479974] ACPI: Added _OSI(Module Device)821worker # [ 0.480627] ACPI: Added _OSI(Processor Device)822worker # [ 0.485626] ACPI: Added _OSI(Processor Aggregator Device)823worker # [ 0.490475] ACPI: 1 ACPI AML tables successfully acquired and loaded824worker # [ 0.494450] ACPI: Interpreter enabled825worker # [ 0.495522] ACPI: PM: (supports S0 S3 S4 S5)826worker # [ 0.498626] ACPI: Using IOAPIC for interrupt routing827worker # [ 0.499651] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug828worker # [ 0.502626] PCI: Using E820 reservations for host bridge windows829worker # [ 0.503785] ACPI: Enabled 2 GPEs in block 00 to 0F830worker # [ 0.511671] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])831worker # [ 0.512633] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]832worker # [ 0.513995] acpiphp: Slot [3] registered833worker # [ 0.514670] acpiphp: Slot [4] registered834worker # [ 0.515680] acpiphp: Slot [5] registered835worker # [ 0.516674] acpiphp: Slot [6] registered836worker # [ 0.517711] acpiphp: Slot [7] registered837worker # [ 0.518669] acpiphp: Slot [8] registered838worker # [ 0.519682] acpiphp: Slot [9] registered839worker # [ 0.520668] acpiphp: Slot [10] registered840worker # [ 0.521667] acpiphp: Slot [11] registered841worker # [ 0.522680] acpiphp: Slot [12] registered842worker # [ 0.523667] acpiphp: Slot [13] registered843worker # [ 0.524659] acpiphp: Slot [14] registered844worker # [ 0.525659] acpiphp: Slot [15] registered845worker # [ 0.526683] acpiphp: Slot [16] registered846worker # [ 0.527660] acpiphp: Slot [17] registered847worker # [ 0.528659] acpiphp: Slot [18] registered848worker # [ 0.529659] acpiphp: Slot [19] registered849worker # [ 0.530680] acpiphp: Slot [20] registered850worker # [ 0.531660] acpiphp: Slot [21] registered851worker # [ 0.532658] acpiphp: Slot [22] registered852worker # [ 0.533659] acpiphp: Slot [23] registered853worker # [ 0.534672] acpiphp: Slot [24] registered854worker # [ 0.535660] acpiphp: Slot [25] registered855worker # [ 0.536659] acpiphp: Slot [26] registered856worker # [ 0.537697] acpiphp: Slot [27] registered857worker # [ 0.538661] acpiphp: Slot [28] registered858worker # [ 0.539683] acpiphp: Slot [29] registered859worker # [ 0.540660] acpiphp: Slot [30] registered860worker # [ 0.541673] acpiphp: Slot [31] registered861worker # [ 0.542649] PCI host bridge to bus 0000:00862worker # [ 0.543633] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]863worker # [ 0.544628] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]864worker # [ 0.545627] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]865worker # [ 0.546627] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]866worker # [ 0.547628] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]867worker # [ 0.548629] pci_bus 0000:00: root bus resource [bus 00-ff]868worker # [ 0.549967] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint869worker # [ 0.551544] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint870worker # [ 0.553531] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint871worker # [ 0.556422] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f]872worker # [ 0.557691] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk873worker # [ 0.558627] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk874worker # [ 0.559627] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk875worker # [ 0.560627] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk876worker # [ 0.562027] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint877worker # [ 0.563692] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f]878worker # [ 0.565839] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint879worker # [ 0.567249] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI880worker # [ 0.568662] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB881worker # [ 0.570023] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint882worker # [ 0.572705] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]883worker # [ 0.573658] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]884worker # [ 0.574679] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]885worker # [ 0.575861] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]886worker # [ 0.577671] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint887worker # [ 0.580668] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]888worker # [ 0.581641] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]889worker # [ 0.582679] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]890worker # [ 0.583641] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]891worker # [ 0.586788] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint892worker # [ 0.589662] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f]893worker # [ 0.590967] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]894worker # [ 0.591704] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]895worker # [ 0.594674] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint896worker # [ 0.597628] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf]897worker # [ 0.598641] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]898worker # [ 0.599679] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]899worker # [ 0.602626] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint900worker # [ 0.605641] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df]901worker # [ 0.607643] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]902worker # [ 0.608706] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]903worker # [ 0.611614] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint904worker # [ 0.614663] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]905worker # [ 0.615641] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]906worker # [ 0.616679] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]907worker # [ 0.619615] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint908worker # [ 0.622664] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff]909worker # [ 0.623641] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]910worker # [ 0.624678] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]911worker # [ 0.628265] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint912worker # [ 0.631627] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff]913worker # [ 0.632641] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]914worker # [ 0.633687] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]915worker # [ 0.634641] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]916worker # [ 0.637585] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint917worker # [ 0.639654] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]918worker # [ 0.640679] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]919worker # [ 0.643599] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint920worker # [ 0.646669] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f]921worker # [ 0.647641] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]922worker # [ 0.648679] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]923worker # [ 0.651652] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint924worker # [ 0.654627] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f]925worker # [ 0.655641] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]926worker # [ 0.656678] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]927worker # [ 0.665002] ACPI: PCI: Interrupt link LNKA configured for IRQ 10928worker # [ 0.665841] ACPI: PCI: Interrupt link LNKB configured for IRQ 10929worker # [ 0.666825] ACPI: PCI: Interrupt link LNKC configured for IRQ 11930worker # [ 0.667819] ACPI: PCI: Interrupt link LNKD configured for IRQ 11931worker # [ 0.668732] ACPI: PCI: Interrupt link LNKS configured for IRQ 9932worker # [ 0.670925] iommu: Default domain type: Translated933worker # [ 0.671637] iommu: DMA domain TLB invalidation policy: lazy mode934worker # [ 0.672918] ACPI: bus type USB registered935worker # [ 0.673683] usbcore: registered new interface driver usbfs936worker # [ 0.674656] usbcore: registered new interface driver hub937worker # [ 0.675650] usbcore: registered new device driver usb938worker # [ 0.677522] NetLabel: Initializing939worker # [ 0.678456] NetLabel: domain hash size = 128940worker # [ 0.679626] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO941worker # [ 0.680671] NetLabel: unlabeled traffic allowed by default942worker # [ 0.681642] PCI: Using ACPI for IRQ routing943worker # [ 0.683255] pci 0000:00:02.0: vgaarb: setting as boot VGA device944worker # [ 0.683622] pci 0000:00:02.0: vgaarb: bridge control possible945worker # [ 0.683622] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none946worker # [ 0.683629] vgaarb: loaded947worker # [ 0.684770] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0948worker # [ 0.685627] hpet0: 3 comparators, 64-bit 100.000000 MHz counter949worker # [ 0.690708] clocksource: Switched to clocksource kvm-clock950worker # [ 0.694719] VFS: Disk quotas dquot_6.6.0951worker # [ 0.695975] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)952worker # [ 0.698211] pnp: PnP ACPI init953worker # [ 0.699874] pnp: PnP ACPI: found 6 devices954worker # [ 0.708110] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns955worker # [ 0.710675] clocksource: Switched to clocksource acpi_pm956worker # [ 0.712412] NET: Registered PF_INET protocol family957worker # [ 0.714220] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)958worker # [ 0.732575] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)959worker # [ 0.735237] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)960worker # [ 0.737505] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)961worker # [ 0.739910] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)962worker # [ 0.742091] TCP: Hash tables configured (established 16384 bind 16384)963worker # [ 0.744071] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)964worker # [ 0.746290] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)965worker # [ 0.748253] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)966worker # [ 0.750385] NET: Registered PF_UNIX/PF_LOCAL protocol family967worker # [ 0.752066] NET: Registered PF_XDP protocol family968worker # [ 0.753576] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]969worker # [ 0.755410] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]970worker # [ 0.757194] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]971worker # [ 0.759182] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]972worker # [ 0.761177] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]973worker # [ 0.763305] pci 0000:00:01.0: PIIX3: Enabling Passive Release974worker # [ 0.765049] pci 0000:00:00.0: Limiting direct PCI/PCI transfers975worker # [ 0.768363] ACPI: \_SB_.LNKD: Enabled at IRQ 11976worker # [ 0.771739] PCI: CLS 0 bytes, default 64977worker # [ 0.773300] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns978worker # [ 0.776265] Trying to unpack rootfs image as initramfs...979worker # [ 0.825248] Initialise system trusted keyrings980worker # [ 0.829882] workingset: timestamp_bits=40 max_order=19 bucket_order=0981worker # [ 0.852237] Key type asymmetric registered982hub # [ 3.873282] systemd[1]: Mounting /sysroot/nix/.ro-store...983worker # [ 0.855852] Asymmetric key parser 'x509' registered984worker # [ 0.857387] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)985hub # [ 3.882712] systemd[1]: Mounting /sysroot/nix/.rw-store...986worker # [ 0.864982] io scheduler mq-deadline registered987worker # [ 0.867847] io scheduler kyber registered988worker # [ 0.872852] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled989hub # [ 3.894202] systemd[1]: Mounting /sysroot/run...990worker # [ 0.877137] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A991worker # [ 0.885983] Linux agpgart interface v0.103992worker # [ 0.887324] ACPI: bus type drm_connector registered993hub # [ 3.908226] systemd[1]: Mounting /sysroot/tmp/shared...994worker # [ 0.893355] usbcore: registered new interface driver usbserial_generic995worker # [ 0.895254] usbserial: USB Serial support registered for generic996worker # [ 0.899864] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.997hub # [ 3.923197] systemd[1]: Mounting /sysroot/tmp/xchg...998worker # [ 0.899864] Please enable it if your BIOS has the CPPC option.999worker # [ 0.903785] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1000worker # [ 0.911979] drop_monitor: Initializing network drop monitor service1001worker # [ 0.913996] NET: Registered PF_INET6 protocol family1002worker # [ 0.919944] Segment Routing with IPv61003worker # [ 0.921155] In-situ OAM (IOAM) with IPv61004worker # [ 0.925211] IPI shorthand broadcast: enabled1005hub # [ 4.195492] 9p: Installing v9fs 9p2000 file system support1006worker # [ 0.934000] sched_clock: Marking stable (695028418, 238793477)->(1124277358, -190455463)1007worker # [ 0.942037] registered taskstats version 11008hub # [ 3.965706] systemd[1]: Mounted /sysroot/nix/.rw-store.1009worker # [ 0.943605] Loading compiled-in X.509 certificates1010hub # [ 3.971307] systemd[1]: Mounted /sysroot/nix/.ro-store.1011hub # [ 3.975821] systemd[1]: Mounted /sysroot/run.1012hub # [ 3.978957] systemd[1]: Mounted /sysroot/tmp/shared.1013hub # [ 3.980654] systemd[1]: Mounted /sysroot/tmp/xchg.1014worker # [ 0.965678] Demotion targets for Node 0: null1015hub # [ 3.987722] systemd[1]: Starting rw-sysroot-nix-store.service...1016worker # [ 0.969000] Key type .fscrypt registered1017worker # [ 0.971837] Key type fscrypt-provisioning registered1018worker # [ 0.973459] ima: No TPM chip found, activating TPM-bypass!1019hub # [ 3.999071] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1020worker # [ 0.978845] ima: Allocated hash algorithm: sha11021hub # [ 4.002095] systemd[1]: Finished rw-sysroot-nix-store.service.1022worker # [ 0.980282] ima: No architecture policies found1023worker # [ 0.984010] PM: Magic number: 2:70:6771024worker # [ 0.988178] RAS: Correctable Errors collector initialized.1025worker # [ 0.999695] clk: Disabling unused clocks1026worker # [ 1.002843] PM: genpd: Disabling unused power domains1027worker # [ 1.138949] Freeing initrd memory: 29528K1028worker # [ 1.142724] Freeing unused decrypted memory: 2028K1029worker # [ 1.146117] Freeing unused kernel image (initmem) memory: 3636K1030worker # [ 1.147993] Write protecting the kernel read-only data: 32768k1031worker # [ 1.150728] Freeing unused kernel image (text/rodata gap) memory: 1272K1032worker # [ 1.153222] Freeing unused kernel image (rodata/data gap) memory: 796K1033worker # [ 1.206184] x86/mm: Checked W+X mappings: passed, no W+X pages found.1034worker # [ 1.208149] Run /init as init process1035worker # [ 1.219415] systemd[1]: Inserted module 'autofs4'1036worker # [ 1.236205] fuse: init (API version 7.45)1037worker # [ 1.243739] ACPI: \_SB_.LNKC: Enabled at IRQ 101038worker # [ 1.252488] ACPI: \_SB_.LNKA: Enabled at IRQ 101039worker # [ 1.257042] ACPI: \_SB_.LNKB: Enabled at IRQ 111040worker # [ 1.296766] systemd[1]: Successfully made /usr/ read-only.1041worker # [ 1.636462] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1042worker # [ 1.658004] systemd[1]: Detected virtualization kvm.1043worker # [ 1.661997] systemd[1]: Detected architecture x86-64.1044worker # [ 1.665906] systemd[1]: Running in initrd.1045worker # [ 1.669961] systemd[1]: Initializing machine ID from random generator.1046worker # [ 1.675085] systemd[1]: Hostname set to <worker>.1047hub # [ 4.873406] systemd[1]: Mounting /sysroot/nix/store...1048worker # [ 1.893344] systemd[1]: bpf-restrict-fs: LSM BPF program attached1049hub # [ 4.925559] systemd[1]: Mounted /sysroot/nix/store.1050hub # [ 4.928131] systemd[1]: Reached target Initrd File Systems.1051hub # [ 4.934274] systemd[1]: Starting Find NixOS closure...1052hub # [ 4.940111] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1053hub # [ 4.963150] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1054hub # [ 4.966918] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1055worker # [ 1.953541] systemd[1]: Queued start job for default target Initrd Default Target.1056hub # [ 4.976770] systemd[1]: Finished Find NixOS closure.1057hub # [ 4.979303] systemd[1]: Reached target Initrd Default Target.1058hub # [ 4.981579] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1059worker # [ 1.959500] systemd[1]: Created slice Slice /system/modprobe.1060worker # [ 1.961562] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1061worker # [ 1.964025] systemd[1]: Expecting device /dev/disk/by-label/nix-store...1062worker # [ 1.966053] systemd[1]: Expecting device /dev/disk/by-label/nixos...1063worker # [ 1.968006] systemd[1]: Reached target Path Units.1064worker # [ 1.969548] systemd[1]: Reached target Slice Units.1065worker # [ 1.971141] systemd[1]: Reached target Swaps.1066worker # [ 1.972652] systemd[1]: Reached target Timer Units.1067worker # [ 1.974439] systemd[1]: Listening on D-Bus System Message Bus Socket.1068hub # [ 4.998429] systemd[1]: Stopped target Initrd Default Target.1069worker # [ 1.976537] systemd[1]: Listening on Journal Socket (/dev/log).1070hub # [ 4.999961] systemd[1]: Stopped target Basic System.1071worker # [ 1.978568] systemd[1]: Listening on Journal Sockets.1072hub # [ 5.001353] systemd[1]: Stopped target Initrd Root Device.1073worker # [ 1.980337] systemd[1]: Listening on udev Control Socket.1074hub # [ 5.002812] systemd[1]: Stopped target Path Units.1075worker # [ 1.982110] systemd[1]: Listening on udev Kernel Socket.1076hub # [ 5.004181] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1077worker # [ 1.983858] systemd[1]: Reached target Socket Units.1078hub # [ 5.006615] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1079worker # [ 1.986535] systemd[1]: Starting Create List of Static Device Nodes...1080hub # [ 5.009324] systemd[1]: Stopped target Slice Units.1081hub # [ 5.010701] systemd[1]: Stopped target Socket Units.1082hub # [ 5.013203] systemd[1]: Stopped target System Initialization.1083hub # [ 5.014836] systemd[1]: Stopped target Swaps.1084worker # [ 1.993042] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1085hub # [ 5.016116] systemd[1]: Stopped target Timer Units.1086hub # [ 5.017475] systemd[1]: dbus.socket: Deactivated successfully.1087hub # [ 5.019669] systemd[1]: Closed D-Bus System Message Bus Socket.1088hub # [ 5.021553] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1089hub # [ 5.024231] systemd[1]: Stopped Find NixOS closure.1090worker # [ 2.004027] systemd[1]: Starting Load Kernel Module configfs...1091hub # [ 5.025592] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1092hub # [ 5.028592] systemd[1]: Starting rw-sysroot-nix-store.service...1093hub # [ 5.030900] systemd[1]: systemd-sysctl.service: Deactivated successfully.1094hub # [ 5.033212] systemd[1]: Stopped Apply Kernel Variables.1095hub # [ 5.034872] systemd[1]: systemd-modules-load.service: Deactivated successfully.1096hub # [ 5.037197] systemd[1]: Stopped Load Kernel Modules.1097hub # [ 5.039257] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1098worker # [ 2.017921] systemd[1]: Starting Journal Service...1099hub # [ 5.041255] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1100hub # [ 5.044044] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1101hub # [ 5.046589] systemd[1]: Stopped Create System Files and Directories.1102hub # [ 5.048262] systemd[1]: Stopped target Local File Systems.1103hub # [ 5.051179] systemd[1]: Stopped target Preparation for Local File Systems.1104hub # [ 5.052940] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1105hub # [ 5.055232] systemd[1]: Stopped Coldplug All udev Devices.1106hub # [ 5.057549] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1107worker # [ 2.035975] systemd[1]: Starting Load Kernel Modules...1108hub # [ 5.060478] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1109hub # [ 5.063435] systemd[1]: Stopped Virtual Console Setup.1110hub # [ 5.074145] systemd[1]: initrd-cleanup.service: Deactivated successfully.1111worker # [ 2.040975] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1112worker # [ 2.056210] netfs: FS-Cache loaded1113hub # [ 5.080845] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1114worker # [ 2.061577] 9pnet: Installing 9P2000 support1115hub # [ 5.084987] systemd[1]: systemd-udevd.service: Deactivated successfully.1116hub # [ 5.087174] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1117hub # [ 5.089688] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1118hub # [ 5.092286] systemd[1]: Finished rw-sysroot-nix-store.service.1119hub # [ 5.096796] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1120hub # [ 5.098783] systemd[1]: Closed udev Control Socket.1121worker # [ 2.076525] systemd[1]: Starting Coldplug All udev Devices...1122hub # [ 5.101209] systemd[1]: Starting Cleanup udev Database...1123hub # [ 5.103155] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1124hub # [ 5.105969] systemd[1]: Stopped Create Static Device Nodes in /dev.1125hub # [ 5.107637] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1126hub # [ 5.109642] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1127hub # [ 5.112228] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1128worker # [ 2.090536] systemd-journald[67]: Collecting audit messages is disabled.1129hub # [ 5.114052] systemd[1]: Stopped Create List of Static Device Nodes.1130worker # [ 2.095971] systemd[1]: Finished Create List of Static Device Nodes.1131worker # [ 2.105593] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1132hub # [ 5.129681] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1133hub # [ 5.132473] systemd[1]: Finished Cleanup udev Database.1134hub # [ 5.134712] systemd[1]: Reached target Switch Root.1135hub # [ 5.137784] systemd[1]: Starting NixOS Activation...1136worker # [ 2.117905] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1137worker # [ 2.122675] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1138worker # [ 2.130385] systemd[1]: modprobe@configfs.service: Deactivated successfully.1139worker # [ 2.138476] systemd[1]: Finished Load Kernel Module configfs.1140worker # [ 2.142961] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1141worker # [ 2.148578] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1142worker # [ 2.166070] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1143worker # [ 2.189914] systemd[1]: Finished Load Kernel Modules.1144worker # [ 2.202937] systemd[1]: Starting Apply Kernel Variables...1145worker # [ 2.220960] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1146worker # [ 2.234285] systemd[1]: Starting Create Static Device Nodes in /dev...1147worker # [ 2.251522] systemd[1]: Finished Apply Kernel Variables.1148worker # [ 2.275003] systemd[1]: Finished Create Static Device Nodes in /dev.1149worker # [ 2.281195] systemd[1]: Reached target Preparation for Local File Systems.1150worker # [ 2.287938] systemd[1]: Reached target Local File Systems.1151hub # [ 5.312056] initrd-nixos-activation-start[180]: booting system configuration /nix/store/zgzkwzc0py7zqi6y54rgz8qp7jlgacvz-nixos-system-hub-test1152worker # [ 2.297134] systemd[1]: Starting Rule-based Manager for Device Events and Files...1153worker # [ 2.061185] systemd-modules-load[68]: Inserted module 'dm_mod'1154worker # [ 2.064647] systemd-modules-load[68]: Inserted module 'virtio_balloon'1155worker # [ 2.066629] systemd-modules-load[68]: Inserted module 'virtio_gpu'1156worker # [ 2.315061] systemd[1]: Started Journal Service.1157worker # [ 2.101138] systemd[1]: Starting Create System Files and Directories...1158hub # [ 5.383598] initrd-nixos-activation-start[180]: running activation script...1159worker # [ 2.133345] systemd-udevd[75]: Using default interface naming scheme 'v261'.1160worker # [ 2.139125] systemd[1]: Finished Create System Files and Directories.1161worker # [ 2.171110] systemd[1]: Started Rule-based Manager for Device Events and Files.1162worker # [ 2.223154] systemd[1]: Finished Coldplug All udev Devices.1163worker # [ 2.224772] systemd[1]: Reached target System Initialization.1164worker # [ 2.226334] systemd[1]: Reached target Basic System.1165worker # [ 2.757453] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121166worker # [ 2.782251] serio: i8042 KBD port at 0x60,0x64 irq 11167worker # [ 2.787442] uhci_hcd 0000:00:01.2: UHCI Host Controller1168worker # [ 2.808118] serio: i8042 AUX port at 0x60,0x64 irq 121169worker # [ 2.811951] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11170hub # [ 5.841701] initrd-nixos-activation-start[203]: setting up /etc...1171worker # [ 2.828596] uhci_hcd 0000:00:01.2: detected 2 ports1172worker # [ 2.832637] SCSI subsystem initialized1173worker # [ 2.838271] virtio_blk virtio4: 1/0/0 default/read/poll queues1174worker # [ 2.841311] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1401175worker # [ 2.851118] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1176worker # [ 2.858640] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181177worker # [ 2.877303] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11178worker # [ 2.892379] virtio_blk virtio5: 1/0/0 default/read/poll queues1179worker # [ 2.657111] systemd[1]: Starting Virtual Console Setup...1180worker # [ 2.902839] usb usb1: Product: UHCI Host Controller1181worker # [ 2.672308] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1182worker # [ 2.920829] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd1183worker # [ 2.928547] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01184worker # [ 2.694104] (udev-worker)[88]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1185worker # [ 2.697756] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1186worker # [ 2.705378] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1187worker # [ 2.711308] systemd[1]: Finished Virtual Console Setup.1188worker # [ 2.953843] virtio_blk virtio5: [vdb] 2081880 512-byte logical blocks (1.07 GB/1017 MiB)1189worker # [ 2.955733] usb usb1: SerialNumber: 0000:00:01.21190worker # [ 2.967405] hub 1-0:1.0: USB hub found1191worker # [ 2.972512] hub 1-0:1.0: 2 ports detected1192worker # [ 3.017376] scsi host0: ata_piix1193worker # [ 3.022419] scsi host1: ata_piix1194worker # [ 3.027012] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 01195worker # [ 2.793841] systemd[1]: Found device /dev/disk/by-label/nix-store.1196worker # [ 3.036929] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 01197worker # [ 2.803171] systemd[1]: Found device /dev/disk/by-label/nixos.1198worker # [ 2.806533] systemd[1]: Reached target Initrd Root Device.1199worker # [ 2.808785] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1200worker # [ 2.831428] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks1201worker # [ 2.839283] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1202worker # [ 2.852543] systemd[1]: Mounting /sysroot...1203hub # [ 6.145214] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1204hub # [ 6.147336] systemd[1]: Finished NixOS Activation.1205hub # [ 6.150217] systemd[1]: Starting Switch Root...1206hub # [ 6.164392] systemd[1]: Switching root.1207worker # [ 3.197108] ata2: found unknown device (class 0)1208worker # [ 3.199251] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001209worker # [ 3.202528] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51210worker # [ 3.205843] usb 1-1: new full-speed USB device number 2 using uhci_hcd1211worker # [ 3.256577] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1212worker # [ 3.273242] cdrom: Uniform CD-ROM driver Revision: 3.201213hub # [ 6.535182] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1214worker # [ 3.294487] EXT4-fs (vda): mounted filesystem 222ce66b-4f53-48b8-af0b-d72e1bbec002 r/w with ordered data mode. Quota mode: none.1215worker # [ 3.061795] systemd[1]: Mounted /sysroot.1216worker # [ 3.066102] systemd[1]: Reached target Initrd Root File System.1217worker # [ 3.070108] systemd[1]: Starting Mountpoints Configured in the Real Root...1218worker # [ 3.084589] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload.1219worker # [ 3.093108] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)...1220worker # [ 3.095793] systemd[1]: Reloading...1221worker # [ 3.375037] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001222worker # [ 3.376995] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101223worker # [ 3.382710] usb 1-1: Product: QEMU USB Tablet1224worker # [ 3.385833] usb 1-1: Manufacturer: QEMU1225worker # [ 3.387731] usb 1-1: SerialNumber: 28754-0000:00:01.2-11226worker # [ 3.429550] hid: raw HID events driver (C) Jiri Kosina1227hub # [ 6.698981] NET: Registered PF_VSOCK protocol family1228worker # [ 3.452544] usbcore: registered new interface driver usbhid1229worker # [ 3.457925] usbhid: USB HID core driver1230worker # [ 3.468051] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21231worker # [ 3.474959] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01232worker # [ 3.256480] systemd[1]: Reloading finished in 163 ms.1233worker # [ 3.266934] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace...1234worker # [ 3.277247] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace...1235worker # [ 3.281806] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1236worker # [ 3.284304] systemd[1]: Finished Mountpoints Configured in the Real Root.1237worker # [ 3.287104] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1238worker # [ 3.290429] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1239hub # [ 7.087210] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1240hub # [ 7.103334] systemd[1]: Detected virtualization kvm.1241hub # [ 7.106519] systemd[1]: Detected architecture x86-64.1242hub # [ 7.109810] systemd[1]: Detected first boot.1243hub # [ 7.117660] systemd[1]: Initializing machine ID from random generator.1244worker # [ 3.855283] systemd[1]: Mounting /sysroot/nix/.ro-store...1245hub # [ 7.360689] systemd[1]: bpf-restrict-fs: LSM BPF program attached1246worker # [ 3.864273] systemd[1]: Mounting /sysroot/nix/.rw-store...1247worker # [ 3.876407] systemd[1]: Mounting /sysroot/run...1248worker # [ 3.888472] systemd[1]: Mounting /sysroot/tmp/shared...1249worker # [ 3.903721] systemd[1]: Mounting /sysroot/tmp/xchg...1250worker # [ 3.937402] systemd[1]: Mounted /sysroot/nix/.rw-store.1251worker # [ 3.950217] systemd[1]: Starting rw-sysroot-nix-store.service...1252worker # [ 4.193875] erofs (device vdb): mounted with root inode @ nid 36.1253worker # [ 4.201001] 9p: Installing v9fs 9p2000 file system support1254worker # [ 3.964658] systemd[1]: Mounted /sysroot/run.1255worker # [ 3.973481] systemd[1]: Mounted /sysroot/nix/.ro-store.1256worker # [ 3.981698] systemd[1]: Mounted /sysroot/tmp/shared.1257worker # [ 3.985224] systemd[1]: Mounted /sysroot/tmp/xchg.1258worker # [ 3.989103] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1259worker # [ 3.991752] systemd[1]: Finished rw-sysroot-nix-store.service.1260hub # [ 7.499670] systemd[1]: Applying preset policy.1261hub # [ 8.050405] systemd[1]: Populated /etc with preset unit settings.1262worker # [ 4.854951] systemd[1]: Mounting /sysroot/nix/store...1263worker # [ 4.906581] systemd[1]: Mounted /sysroot/nix/store.1264worker # [ 4.908723] systemd[1]: Reached target Initrd File Systems.1265worker # [ 4.912221] systemd[1]: Starting Find NixOS closure...1266worker # [ 4.918764] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1267worker # [ 4.941344] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1268worker # [ 4.946123] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1269worker # [ 4.955105] systemd[1]: Finished Find NixOS closure.1270worker # [ 4.957275] systemd[1]: Reached target Initrd Default Target.1271worker # [ 4.959749] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1272worker # [ 4.975292] systemd[1]: Stopped target Initrd Default Target.1273worker # [ 4.978093] systemd[1]: Stopped target Basic System.1274worker # [ 4.979479] systemd[1]: Stopped target Initrd Root Device.1275worker # [ 4.980970] systemd[1]: Stopped target Path Units.1276worker # [ 4.982703] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1277worker # [ 4.984966] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1278worker # [ 4.987597] systemd[1]: Stopped target Slice Units.1279worker # [ 4.990382] systemd[1]: Stopped target Socket Units.1280worker # [ 4.991770] systemd[1]: Stopped target System Initialization.1281worker # [ 4.993312] systemd[1]: Stopped target Swaps.1282worker # [ 4.994722] systemd[1]: Stopped target Timer Units.1283worker # [ 4.996727] systemd[1]: dbus.socket: Deactivated successfully.1284worker # [ 4.998323] systemd[1]: Closed D-Bus System Message Bus Socket.1285worker # [ 5.000293] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1286worker # [ 5.003248] systemd[1]: Stopped Find NixOS closure.1287worker # [ 5.004611] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1288worker # [ 5.007335] systemd[1]: Starting rw-sysroot-nix-store.service...1289worker # [ 5.010186] systemd[1]: systemd-sysctl.service: Deactivated successfully.1290worker # [ 5.011922] systemd[1]: Stopped Apply Kernel Variables.1291worker # [ 5.013492] systemd[1]: systemd-modules-load.service: Deactivated successfully.1292worker # [ 5.015343] systemd[1]: Stopped Load Kernel Modules.1293worker # [ 5.018235] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1294worker # [ 5.020265] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1295worker # [ 5.022260] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1296worker # [ 5.024153] systemd[1]: Stopped Create System Files and Directories.1297worker # [ 5.025759] systemd[1]: Stopped target Local File Systems.1298worker # [ 5.027872] systemd[1]: Stopped target Preparation for Local File Systems.1299worker # [ 5.030232] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1300worker # [ 5.033306] systemd[1]: Stopped Coldplug All udev Devices.1301worker # [ 5.035711] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1302worker # [ 5.037602] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1303worker # [ 5.040163] systemd[1]: Stopped Virtual Console Setup.1304worker # [ 5.056191] systemd[1]: initrd-cleanup.service: Deactivated successfully.1305worker # [ 5.061321] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1306worker # [ 5.063172] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1307worker # [ 5.066115] systemd[1]: Finished rw-sysroot-nix-store.service.1308worker # [ 5.068328] systemd[1]: systemd-udevd.service: Deactivated successfully.1309worker # [ 5.070799] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1310worker # [ 5.074673] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1311worker # [ 5.076701] systemd[1]: Closed udev Control Socket.1312worker # [ 5.079198] systemd[1]: Starting Cleanup udev Database...1313worker # [ 5.080816] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1314worker # [ 5.083100] systemd[1]: Stopped Create Static Device Nodes in /dev.1315worker # [ 5.084727] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1316worker # [ 5.087192] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1317worker # [ 5.089217] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1318worker # [ 5.092204] systemd[1]: Stopped Create List of Static Device Nodes.1319worker # [ 5.109931] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1320worker # [ 5.112178] systemd[1]: Finished Cleanup udev Database.1321worker # [ 5.114392] systemd[1]: Reached target Switch Root.1322worker # [ 5.116835] systemd[1]: Starting NixOS Activation...1323hub # [ 8.638686] systemd[1]: initrd-switch-root.service: Deactivated successfully.1324hub # [ 8.641209] systemd[1]: Stopped initrd-switch-root.service.1325hub # [ 8.645114] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1326hub # [ 8.648273] systemd[1]: Created slice Slice /system/getty.1327hub # [ 8.650321] systemd[1]: Created slice User and Session Slice.1328hub # [ 8.651848] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1329hub # [ 8.654031] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1330hub # [ 8.655832] systemd[1]: Expecting device /dev/hvc0...1331hub # [ 8.657110] systemd[1]: Expecting device /dev/ttyS0...1332hub # [ 8.658417] systemd[1]: Reached target Local Encrypted Volumes.1333hub # [ 8.659844] systemd[1]: Stopped target initrd-fs.target.1334hub # [ 8.661199] systemd[1]: Stopped target initrd-root-fs.target.1335hub # [ 8.662598] systemd[1]: Stopped target initrd-switch-root.target.1336hub # [ 8.664135] systemd[1]: Reached target Virtual Machines and Containers.1337hub # [ 8.665709] systemd[1]: Reached target Path Units.1338hub # [ 8.666992] systemd[1]: Reached target Remote File Systems.1339hub # [ 8.668378] systemd[1]: Reached target Slice Units.1340hub # [ 8.669643] systemd[1]: Reached target Swaps.1341worker # [ 5.171335] initrd-nixos-activation-start[183]: booting system configuration /nix/store/jfblc23in63zx144sr9kfhfhdc5fyhn9-nixos-system-worker-test1342hub # [ 8.674438] systemd[1]: Listening on Query the User Interactively for a Password.1343hub # [ 8.679988] systemd[1]: Listening on Process Core Dump Socket.1344hub # [ 8.684324] systemd[1]: Listening on Credential Encryption/Decryption.1345hub # [ 8.688566] systemd[1]: Listening on Factory Reset Management.1346hub # [ 8.690195] systemd[1]: Listening on Hostname Service Socket.1347worker # [ 5.191525] initrd-nixos-activation-start[183]: running activation script...1348hub # [ 8.695612] systemd[1]: Starting Journal Log Access Socket...1349hub # [ 8.698043] systemd[1]: Listening on Journal Audit Socket.1350hub # [ 8.702271] systemd[1]: Listening on Console Output Muting Service Socket.1351hub # [ 8.704292] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1352hub # [ 8.706794] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1353hub # [ 8.708999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1354hub # [ 8.723511] systemd[1]: Listening on Disk Repartitioning Service Socket.1355hub # [ 8.725299] systemd[1]: Listening on udev Control Socket.1356hub # [ 8.726825] systemd[1]: Listening on udev Varlink Socket.1357hub # [ 8.732093] systemd[1]: Mounting Huge Pages File System...1358hub # [ 8.736810] systemd[1]: Mounting POSIX Message Queue File System...1359hub # [ 8.744998] systemd[1]: Mounting Kernel Debug File System...1360hub # [ 8.753388] systemd[1]: Mounting Kernel Trace File System...1361hub # [ 8.762413] systemd[1]: Starting Create List of Static Device Nodes...1362hub # [ 8.764446] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1363hub # [ 8.777383] systemd[1]: Starting Load Kernel Module configfs...1364hub # [ 8.780016] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1365hub # [ 8.782853] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1366hub # [ 8.786137] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1367hub # [ 8.796011] systemd[1]: Mounting FUSE Control File System...1368hub # [ 8.797505] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671369worker # [ 5.330308] initrd-nixos-activation-start[206]: setting up /etc...1370hub # [ 8.831551] systemd[1]: Starting Journal Service...1371hub # [ 8.852593] systemd[1]: Starting Load Kernel Modules...1372hub # [ 8.873744] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1373hub # [ 8.889219] systemd[1]: Starting Remount Root and Kernel File Systems...1374hub # [ 8.896629] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1375worker # [ 5.402677] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1376worker # [ 5.406113] systemd[1]: Finished NixOS Activation.1377worker # [ 5.408538] systemd[1]: Starting Switch Root...1378hub # [ 8.908331] systemd-journald[273]: Collecting audit messages is enabled.1379hub # [ 8.912280] systemd[1]: Starting Coldplug All udev Devices...1380worker # [ 5.423523] systemd[1]: Switching root.1381hub # [ 8.938657] systemd[1]: Listening on Journal Log Access Socket.1382hub # [ 8.952017] loop: module loaded1383hub # [ 8.956185] systemd[1]: Mounted Huge Pages File System.1384hub # [ 8.722579] systemd[1]: Queued start job for default target Multi-User System.[ 8.963467] systemd[1]: Started Journal Service.1385hub # 1386hub # [ 8.726520] systemd[1]: systemd-journald.service: Deactivated successfully.1387hub # [ 8.736276] systemd-modules-load[274]: Inserted module 'loop'1388hub # [ 8.977047] EXT4-fs (vda): re-mounted 9d58db14-b94d-4020-b2e3-aa6a859fd357.1389hub # [ 8.740436] systemd[1]: Mounted POSIX Message Queue File System.1390hub # [ 8.746906] systemd[1]: Mounted Kernel Debug File System.1391hub # [ 8.748652] systemd[1]: Mounted Kernel Trace File System.1392hub # [ 8.756227] systemd[1]: Finished Create List of Static Device Nodes.1393hub # [ 8.759335] systemd[1]: modprobe@configfs.service: Deactivated successfully.1394hub # [ 8.766279] systemd[1]: Finished Load Kernel Module configfs.1395hub # [ 8.770232] systemd[1]: Mounted FUSE Control File System.1396hub # [ 8.775178] systemd-modules-load[274]: Inserted module 'tls'1397hub # [ 8.777619] systemd[1]: Finished Remount Root and Kernel File Systems.1398hub # [ 8.787866] systemd[1]: Finished Load Kernel Modules.1399hub # [ 8.802128] systemd[1]: Listening on Disk Image Download Service Socket.1400hub # [ 8.811098] systemd[1]: Mounting Kernel Configuration File System...1401worker # [ 5.787898] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1402hub # [ 8.819155] systemd[1]: Starting Firewall...1403hub # [ 8.831925] systemd[1]: Starting Flush Journal to Persistent Storage...1404hub # [ 8.833801] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1405hub # [ 8.839371] systemd-oomd[276]: No swap; memory pressure usage will be degraded1406hub # [ 8.853262] systemd[1]: Starting Load/Save OS Random Seed...1407hub # [ 8.865751] systemd[1]: Starting Apply Kernel Variables...1408worker # [ 5.867026] NET: Registered PF_VSOCK protocol family1409hub # [ 8.890093] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1410hub # [ 8.892170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1411hub # [ 8.903887] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1412hub # [ 9.156484] systemd-journald[273]: Received client request to flush runtime journal.1413hub # [ 9.132109] systemd[1]: Mounted Kernel Configuration File System.1414hub # [ 9.138821] systemd[1]: Finished Load/Save OS Random Seed.1415hub # [ 9.143966] systemd[1]: Reached target First Boot Complete.1416hub # [ 9.150300] systemd[1]: Finished Apply Kernel Variables.1417hub # [ 9.152810] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1418hub # [ 9.155870] systemd[1]: Starting Create Static Device Nodes in /dev...1419hub # [ 9.158511] systemd[1]: Finished Flush Journal to Persistent Storage.1420hub # [ 9.197724] systemd[1]: Finished Create Static Device Nodes in /dev.1421hub # [ 9.200540] systemd[1]: Reached target Preparation for Local File Systems.1422hub # [ 9.206721] systemd[1]: Starting Rule-based Manager for Device Events and Files...1423worker # [ 6.223553] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1424worker # [ 6.239736] systemd[1]: Detected virtualization kvm.1425worker # [ 6.242926] systemd[1]: Detected architecture x86-64.1426worker # [ 6.246139] systemd[1]: Detected first boot.1427worker # [ 6.249946] systemd[1]: Initializing machine ID from random generator.1428hub # [ 9.300160] systemd[1]: Finished Coldplug All udev Devices.1429hub # [ 9.308577] systemd-udevd[317]: Using default interface naming scheme 'v261'.1430hub # [ 9.404274] systemd[1]: Mounting /run/wrappers...1431hub # [ 9.442426] systemd[1]: Mounted /run/wrappers.1432hub # [ 9.443842] systemd[1]: Reached target Local File Systems.1433hub # [ 9.449157] systemd[1]: Listening on Boot Loader Control Service Socket.1434hub # [ 9.455772] systemd[1]: Starting register-nix-paths.service...1435hub # [ 9.461128] systemd[1]: Starting Create SUID/SGID Wrappers...1436hub # [ 9.462694] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1437hub # [ 9.475920] systemd[1]: Starting Save Transient machine-id to Disk...1438hub # [ 9.490072] systemd[1]: Starting Create System Files and Directories...1439hub # [ 9.495291] systemd[1]: Started Rule-based Manager for Device Events and Files.1440worker # [ 6.493680] systemd[1]: bpf-restrict-fs: LSM BPF program attached1441hub # [ 9.571221] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1442hub # [ 9.578927] systemd[1]: Finished Save Transient machine-id to Disk.1443worker # [ 6.609806] systemd[1]: Applying preset policy.1444hub # [ 9.659112] systemd[1]: Finished Create System Files and Directories.1445hub # [ 9.672650] systemd[1]: Starting Rebuild Journal Catalog...1446hub # [ 9.686390] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1447worker # [ 6.732431] systemd[1]: Populated /etc with preset unit settings.1448hub # [ 9.766907] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1449hub # [ 9.820801] systemd[1]: Finished Rebuild Journal Catalog.1450hub # [ 9.828593] systemd[1]: Starting Update is Completed...1451worker # [ 6.842819] systemd[1]: initrd-switch-root.service: Deactivated successfully.1452worker # [ 6.845258] systemd[1]: Stopped initrd-switch-root.service.1453worker # [ 6.848728] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1454worker # [ 6.852039] systemd[1]: Created slice Slice /system/getty.1455worker # [ 6.854114] systemd[1]: Created slice User and Session Slice.1456worker # [ 6.855654] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1457worker # [ 6.857711] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1458worker # [ 6.859573] systemd[1]: Expecting device /dev/hvc0...1459worker # [ 6.860905] systemd[1]: Expecting device /dev/ttyS0...1460worker # [ 6.862221] systemd[1]: Reached target Local Encrypted Volumes.1461worker # [ 6.863668] systemd[1]: Stopped target initrd-fs.target.1462worker # [ 6.865025] systemd[1]: Stopped target initrd-root-fs.target.1463worker # [ 6.866434] systemd[1]: Stopped target initrd-switch-root.target.1464worker # [ 6.868010] systemd[1]: Reached target Virtual Machines and Containers.1465hub # [ 9.890724] systemd[1]: Finished Update is Completed.1466worker # [ 6.869600] systemd[1]: Reached target Path Units.1467worker # [ 6.870886] systemd[1]: Reached target Remote File Systems.1468worker # [ 6.872290] systemd[1]: Reached target Slice Units.1469worker # [ 6.873566] systemd[1]: Reached target Swaps.1470worker # [ 6.875565] systemd[1]: Listening on Query the User Interactively for a Password.1471worker # [ 6.878357] systemd[1]: Listening on Process Core Dump Socket.1472worker # [ 6.880400] systemd[1]: Listening on Credential Encryption/Decryption.1473worker # [ 6.882677] systemd[1]: Listening on Factory Reset Management.1474worker # [ 6.884287] systemd[1]: Listening on Hostname Service Socket.1475worker # [ 6.887380] systemd[1]: Starting Journal Log Access Socket...1476worker # [ 6.889442] systemd[1]: Listening on Journal Audit Socket.1477worker # [ 6.892521] systemd[1]: Listening on Console Output Muting Service Socket.1478worker # [ 6.894395] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1479worker # [ 6.896291] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1480worker # [ 6.898507] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1481worker # [ 6.902224] systemd[1]: Listening on Disk Repartitioning Service Socket.1482worker # [ 6.903995] systemd[1]: Listening on udev Control Socket.1483worker # [ 6.905499] systemd[1]: Listening on udev Varlink Socket.1484worker # [ 6.908854] systemd[1]: Mounting Huge Pages File System...1485worker # [ 6.914384] systemd[1]: Mounting POSIX Message Queue File System...1486worker # [ 6.922921] systemd[1]: Mounting Kernel Debug File System...1487worker # [ 6.933448] systemd[1]: Mounting Kernel Trace File System...1488worker # [ 6.946410] systemd[1]: Starting Create List of Static Device Nodes...1489worker # [ 6.955541] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1490worker # [ 6.974275] systemd[1]: Starting Load Kernel Module configfs...1491worker # [ 6.977878] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1492worker # [ 6.980681] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1493worker # [ 6.983337] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1494worker # [ 6.991368] systemd[1]: Mounting FUSE Control File System...1495worker # [ 6.996916] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671496hub # [ 10.022978] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1497worker # [ 7.007426] systemd[1]: Starting Journal Service...1498worker # [ 7.014412] systemd[1]: Starting Load Kernel Modules...1499worker # [ 7.026041] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1500worker # [ 7.044900] systemd[1]: Starting Remount Root and Kernel File Systems...1501worker # [ 7.053272] systemd-journald[276]: Collecting audit messages is enabled.1502worker # [ 7.057106] loop: module loaded1503worker # [ 7.060891] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1504worker # [ 7.073276] systemd[1]: Starting Coldplug All udev Devices...1505worker # [ 7.090876] EXT4-fs (vda): re-mounted 222ce66b-4f53-48b8-af0b-d72e1bbec002.1506worker # [ 6.867744] systemd[1]: Queued start job for default target Multi-User System.[ 7.109219] systemd[1]: Started Journal Service.1507worker # 1508worker # [ 6.872805] systemd[1]: Unnecessary job was removed for /dev/vdb.1509worker # [ 6.876681] systemd[1]: systemd-journald.service: Deactivated successfully.1510worker # [ 6.882569] systemd-modules-load[277]: Inserted module 'loop'1511worker # [ 6.887595] systemd[1]: Listening on Journal Log Access Socket.1512worker # [ 6.889564] systemd[1]: Mounted Huge Pages File System.1513worker # [ 6.894986] systemd[1]: Mounted POSIX Message Queue File System.1514worker # [ 6.896915] systemd[1]: Mounted Kernel Debug File System.1515worker # [ 6.902897] systemd[1]: Mounted Kernel Trace File System.1516worker # [ 6.904681] systemd[1]: Finished Create List of Static Device Nodes.1517worker # [ 6.910770] systemd[1]: modprobe@configfs.service: Deactivated successfully.1518worker # [ 6.912817] systemd[1]: Finished Load Kernel Module configfs.1519worker # [ 6.916249] systemd[1]: Mounted FUSE Control File System.1520worker # [ 6.919262] systemd[1]: Finished Load Kernel Modules.1521worker # [ 6.923370] systemd[1]: Finished Remount Root and Kernel File Systems.1522hub # [ 10.191093] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1523hub # [ 10.192962] systemd[1]: Finished Create SUID/SGID Wrappers.1524worker # [ 6.945115] systemd[1]: Listening on Disk Image Download Service Socket.1525worker # [ 6.947970] systemd-oomd[279]: No swap; memory pressure usage will be degraded1526worker # [ 6.953118] systemd[1]: Mounting Kernel Configuration File System...1527worker # [ 6.964098] systemd[1]: Starting Firewall...1528worker # [ 6.975104] systemd[1]: Starting Flush Journal to Persistent Storage...1529worker # [ 6.976844] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1530hub # [ 10.247408] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1531worker # [ 6.990112] systemd[1]: Starting Load/Save OS Random Seed...1532worker # [ 7.003146] systemd[1]: Starting Apply Kernel Variables...1533worker # [ 7.020453] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1534worker # [ 7.024739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1535worker # [ 7.026929] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1536hub # [ 10.301675] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1537worker # [ 7.300394] systemd-journald[276]: Received client request to flush runtime journal.1538hub # [ 10.352050] (udev-worker)[391]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1539hub # [ 10.358395] (udev-worker)[391]: Network interface NamePolicy= disabled on kernel command line.1540hub # [ 10.360766] (udev-worker)[393]: Network interface NamePolicy= disabled on kernel command line.1541hub # [ 10.495921] systemd[1]: Finished register-nix-paths.service.1542hub # [ 10.498541] systemd[1]: Reached target System Initialization.1543hub # [ 10.503569] systemd[1]: Started Discard unused filesystem blocks once a week.1544hub # [ 10.506077] systemd[1]: Started Daily Cleanup of Temporary Directories.1545hub # [ 10.508228] systemd[1]: Reached target Timer Units.1546hub # [ 10.511670] systemd[1]: Listening on D-Bus System Message Bus Socket.1547hub # [ 10.513411] systemd[1]: Listening on Nix Daemon Socket.1548hub # [ 10.516214] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1549hub # [ 10.519208] systemd[1]: Reached target Socket Units.1550hub # [ 10.521491] systemd[1]: Reached target Basic System.1551hub # [ 10.527139] systemd[1]: Started backdoor.service.1552hub # [ 10.532452] systemd[1]: Starting Import lastlog data into lastlog2 database...1553hub # [ 10.548325] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1554hub # [ 10.560750] systemd[1]: Starting Post-Boot Actions...1555worker # [ 7.305158] systemd[1]: Mounted Kernel Configuration File System.1556worker # [ 7.312512] systemd[1]: Finished Load/Save OS Random Seed.1557worker # [ 7.315384] systemd[1]: Reached target First Boot Complete.1558worker # [ 7.318619] systemd[1]: Finished Apply Kernel Variables.1559worker # [ 7.322489] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1560hub # [ 10.587386] systemd[1]: Started Reset console on configuration changes.1561worker # [ 7.328731] systemd[1]: Starting Create Static Device Nodes in /dev...1562worker # [ 7.331270] systemd[1]: Finished Create Static Device Nodes in /dev.1563worker # [ 7.335427] systemd[1]: Reached target Preparation for Local File Systems.1564worker # [ 7.338279] systemd[1]: Starting Rule-based Manager for Device Events and Files...1565worker # [ 7.341596] systemd-udevd[316]: Using default interface naming scheme 'v261'.1566worker # [ 7.344634] systemd[1]: Finished Flush Journal to Persistent Storage.1567hub # [ 10.613675] systemd[1]: Starting resolvconf update...1568hub # [ 10.655666] systemd[1]: Finished Firewall.1569worker # [ 7.398630] systemd[1]: Started Rule-based Manager for Device Events and Files.1570hub # connecting to host...1571hub # [ 10.678274] systemd[1]: Finished Post-Boot Actions.1572hub # [ 10.708554] systemd[1]: Condition check resulted in Virtio network device being skipped.1573hub: Guest shell says: b'Spawning backdoor root shell...\n'1574hub: connected to guest root shell1575hub # [ 10.722577] systemd[1]: Starting D-Bus System Message Bus...1576hub: (connecting took 8.38 seconds)1577hub # [ 10.725092] systemd[1]: Started Name Service Cache Daemon (nsncd).1578hub: (finished: waiting for the VM to finish booting, in 8.38 seconds)1579hub # [ 10.730134] nsncd[503]: Jul 13 09:40:04.687 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1580worker # [ 7.471832] systemd[1]: Finished Coldplug All udev Devices.1581hub # [ 10.733574] systemd[1]: Reached target Host and Network Name Lookups.1582hub # [ 10.735238] systemd[1]: Reached target User and Group Name Lookups.1583hub # [ 10.762531] systemd[1]: Starting User Login Management...1584hub # [ 10.768374] systemd[1]: Finished Import lastlog data into lastlog2 database.1585worker # [ 7.612184] systemd[1]: Mounting /run/wrappers...1586worker # [ 7.642527] systemd[1]: Mounted /run/wrappers.1587worker # [ 7.644871] systemd[1]: Reached target Local File Systems.1588worker # [ 7.651110] systemd[1]: Listening on Boot Loader Control Service Socket.1589worker # [ 7.657666] systemd[1]: Starting register-nix-paths.service...1590hub # [ 10.926560] dbus-broker-launch[534]: Looking up NSS user entry for 'systemd-timesync'...1591worker # [ 7.666544] systemd[1]: Starting Create SUID/SGID Wrappers...1592worker # [ 7.669188] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1593hub # [ 10.930477] systemd[1]: Stopped target Host and Network Name Lookups.1594hub # [ 10.934604] systemd[1]: Stopping Host and Network Name Lookups...1595hub # [ 10.938973] systemd[1]: Stopped target User and Group Name Lookups.1596hub # [ 10.941716] systemd[1]: Stopping User and Group Name Lookups...1597hub # [ 10.943297] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1598worker # [ 7.688124] systemd[1]: Starting Save Transient machine-id to Disk...1599hub # [ 10.949065] systemd[1]: nscd.service: Deactivated successfully.1600hub # [ 10.952192] dbus-broker-launch[534]: NSS returned no entry for 'systemd-timesync'1601hub # [ 10.954408] dbus-broker-launch[534]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1602hub # [ 10.959378] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1603worker # [ 7.703104] systemd[1]: Starting Create System Files and Directories...1604worker # [ 7.717221] systemd[1]: Finished Firewall.1605hub # [ 10.980244] systemd-logind[538]: New seat seat0.1606hub # [ 10.986111] systemd[1]: Started User Login Management.1607hub # [ 10.995282] systemd[1]: Starting linger-users.service...1608hub # [ 11.007958] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1609hub # [ 11.012802] systemd[1]: Started D-Bus System Message Bus.1610worker # [ 7.759125] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1611worker # [ 7.772149] systemd[1]: Finished Save Transient machine-id to Disk.1612hub # [ 11.053296] dbus-broker-launch[534]: Ready1613worker # [ 7.792114] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1614worker # [ 7.828302] systemd[1]: Finished Create System Files and Directories.1615worker # [ 7.841471] systemd[1]: Starting Rebuild Journal Catalog...1616hub # [ 11.102370] systemd[1]: linger-users.service: Deactivated successfully.1617hub # [ 11.106417] systemd[1]: Finished linger-users.service.1618hub # [ 11.110833] nsncd[589]: Jul 13 09:40:05.079 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1619hub # [ 11.116211] systemd[1]: Started Name Service Cache Daemon (nsncd).1620worker # [ 7.859116] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1621hub # [ 11.121159] systemd[1]: Reached target Host and Network Name Lookups.1622hub # [ 11.122960] systemd[1]: Reached target User and Group Name Lookups.1623hub # [ 11.366708] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31624hub # [ 11.150329] systemd[1]: Finished resolvconf update.1625hub # [ 11.152224] systemd[1]: Reached target Preparation for Network.1626hub # [ 11.162161] systemd[1]: Starting DHCP Client...1627hub # [ 11.167247] systemd[1]: Starting Address configuration of eth1...1628hub # [ 11.179764] systemd[1]: Starting Extra networking commands....1629worker # [ 7.928532] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1630hub # [ 11.198116] systemd[1]: Starting Tailscale node agent...1631hub # [ 11.471155] ACPI: button: Power Button [PWRF]1632worker # [ 7.974667] systemd[1]: Finished Rebuild Journal Catalog.1633worker # [ 7.984968] systemd[1]: Starting Update is Completed...1634worker # [ 8.036281] systemd[1]: Finished Update is Completed.1635hub # [ 11.554612] rtc_cmos 00:05: RTC can wake from S41636hub # [ 11.560729] mousedev: PS/2 mouse device common for all mice1637hub # [ 11.328550] network-addresses-eth1-start[615]: adding address 192.168.1.1/24... done1638worker # [ 8.094844] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1639hub # [ 11.356687] network-addresses-eth1-start[615]: adding address 2001:db8:1::1/64... done1640hub # [ 11.611646] rtc_cmos 00:05: registered as rtc01641hub # [ 11.620378] rtc_cmos 00:05: setting system clock to 2026-07-13T09:40:05 UTC (1783935605)1642hub # [ 11.396658] systemd[1]: Finished Address configuration of eth1.1643hub # [ 11.637635] parport_pc 00:03: reported by Plug and Play ACPI1644worker # [ 8.147358] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1645hub # [ 11.647526] Floppy drive(s): fd0 is 2.88M AMI BIOS1646worker # [ 8.151107] systemd[1]: Finished Create SUID/SGID Wrappers.1647worker # [ 8.192589] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1648hub # [ 11.695784] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1649hub # [ 11.704777] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1650worker # [ 8.207609] (udev-worker)[387]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1651worker # [ 8.226880] (udev-worker)[387]: Network interface NamePolicy= disabled on kernel command line.1652hub # [ 11.491890] dhcpcd[629]: dhcpcd-10.3.2 starting1653worker # [ 8.233421] (udev-worker)[394]: Network interface NamePolicy= disabled on kernel command line.1654hub # [ 11.742618] FDC 0 is a S82078B1655hub # [ 11.517245] dhcpcd[680]: dev: loaded udev1656hub # [ 11.522624] systemd[1]: Finished Extra networking commands..1657hub # [ 11.526397] systemd[1]: Reached target Network.1658hub # [ 11.537347] systemd[1]: Starting Nginx Web Server...1659hub # [ 11.553064] systemd[1]: Starting Permit User Sessions...1660hub # [ 11.795798] 8021q: 802.1Q VLAN Support v1.81661hub # [ 11.800946] 8021q: adding VLAN 0 to HW filter on device eth11662worker # [ 8.312367] systemd[1]: Finished register-nix-paths.service.1663worker # [ 8.316277] systemd[1]: Reached target System Initialization.1664worker # [ 8.319117] systemd[1]: Started Discard unused filesystem blocks once a week.1665worker # [ 8.320952] systemd[1]: Started Daily Cleanup of Temporary Directories.1666worker # [ 8.323774] systemd[1]: Reached target Timer Units.1667worker # [ 8.326272] systemd[1]: Listening on D-Bus System Message Bus Socket.1668worker # [ 8.328431] systemd[1]: Listening on Nix Daemon Socket.1669worker # [ 8.331331] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1670worker # [ 8.333782] systemd[1]: Listening on tribuchet-sandboxd.socket.1671worker # [ 8.335937] systemd[1]: Reached target Socket Units.1672worker # [ 8.338234] systemd[1]: Reached target Basic System.1673worker # [ 8.340664] systemd[1]: Started backdoor.service.1674worker # [ 8.349208] systemd[1]: Starting Import lastlog data into lastlog2 database...1675worker # [ 8.358109] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1676worker # [ 8.370638] systemd[1]: Starting Post-Boot Actions...1677hub # [ 11.638328] systemd[1]: Finished Permit User Sessions.1678worker # [ 8.384817] systemd[1]: Started Reset console on configuration changes.1679hub # [ 11.651551] systemd[1]: Started Getty on tty1.1680hub # [ 11.655937] systemd[1]: Reached target Login Prompts.1681worker # connecting to host...1682worker # [ 8.411106] systemd[1]: Starting resolvconf update...1683hub # [ 11.917344] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01684hub # [ 11.934438] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1685worker # [ 8.447170] systemd[1]: Finished Post-Boot Actions.1686hub # [ 11.708416] tailscaled[618]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1687worker # [ 8.465586] systemd[1]: Started Name Service Cache Daemon (nsncd).1688worker # [ 8.468781] nsncd[504]: Jul 13 09:40:05.701 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1689hub # [ 11.745489] tailscaled[618]: logtail started1690worker # [ 8.488761] systemd[1]: Condition check resulted in Virtio network device being skipped.1691hub # [ 11.747731] tailscaled[618]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}1692hub # [ 11.755141] tailscaled[618]: LogID: 9e31a15b69986d70ea3409418b77416e2da4de2f74523017bc51d1b750aa0d0e1693worker # [ 8.496340] systemd[1]: Finished Import lastlog data into lastlog2 database.1694hub # [ 11.757988] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1695hub # [ 11.760344] tailscaled[618]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1696worker # [ 8.504109] systemd[1]: Reached target Host and Network Name Lookups.1697hub # [ 11.764602] tailscaled[618]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1698worker # [ 8.505773] systemd[1]: Reached target User and Group Name Lookups.1699worker # [ 8.512109] systemd[1]: Starting D-Bus System Message Bus...1700worker # [ 8.534794] systemd[1]: Starting User Login Management...1701hub # [ 11.826892] dbus-broker-launch[534]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1702hub # [ 11.836876] tailscaled[618]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:42916->[::1]:53: read: connection refused (in 43ms), trying bootstrap...1703hub # [ 11.855868] tailscaled[618]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...1704hub # [ 11.862178] tailscaled[618]: bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.134:443: connect: network is unreachable1705hub # [ 11.866814] tailscaled[618]: trying bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" ...1706worker # [ 8.610368] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'...1707hub # [ 11.869382] tailscaled[618]: bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::e08:e001]:443: connect: network is unreachable1708hub # [ 11.875220] tailscaled[618]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ...1709worker # [ 8.615899] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync'1710hub # [ 11.877745] tailscaled[618]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable1711worker # [ 8.618461] dbus-broker-launch[530]: Invalid user-name in /nix/store/a7agjv2209jvj4cvwy8lz4g35l9gak1c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1712hub # [ 11.884183] tailscaled[618]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...1713worker # [ 8.631163] systemd[1]: Started D-Bus System Message Bus.1714hub # [ 11.890131] tailscaled[618]: bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::287]:443: connect: network is unreachable1715hub # [ 11.894948] tailscaled[618]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ...1716hub # [ 11.897468] tailscaled[618]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable1717hub # [ 11.903086] tailscaled[618]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ...1718hub # [ 11.905883] tailscaled[618]: bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c]:443: connect: network is unreachable1719hub # [ 11.912196] tailscaled[618]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...1720hub # [ 11.915487] tailscaled[618]: bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.134:443: connect: network is unreachable1721hub # [ 11.921832] tailscaled[618]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ...1722worker # [ 8.663338] dbus-broker-launch[530]: Ready1723hub # [ 11.925541] tailscaled[618]: bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:b001]:443: connect: network is unreachable1724hub # [ 11.931537] tailscaled[618]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...1725hub # [ 11.934273] tailscaled[618]: bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 144.202.67.195:443: connect: network is unreachable1726worker # [ 8.678579] systemd-logind[534]: New seat seat0.1727hub # [ 11.939272] tailscaled[618]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ...1728worker # [ 8.683258] systemd[1]: Started User Login Management.1729hub # [ 11.942975] tailscaled[618]: bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7a0:e001]:443: connect: network is unreachable1730hub # [ 11.948646] tailscaled[618]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...1731hub # [ 11.951533] tailscaled[618]: bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.74.153:443: connect: network is unreachable1732worker # [ 8.698398] systemd[1]: Stopped target Host and Network Name Lookups.1733hub # [ 11.958110] tailscaled[618]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ...1734worker # [ 8.702170] systemd[1]: Stopping Host and Network Name Lookups...1735worker # [ 8.703780] systemd[1]: Stopped target User and Group Name Lookups.1736hub # [ 11.961430] tailscaled[618]: bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:1d9c:5400:2ff:feef:bb82]:443: connect: network is unreachable1737worker # [ 8.706562] systemd[1]: Stopping User and Group Name Lookups...1738worker # [ 8.710139] systemd[1]: Starting linger-users.service...1739hub # [ 11.967417] tailscaled[618]: logtail: upload: log upload of 479 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/68f2530c56a968c05b0a96bcaf9ef75a0fef1218d3982eceb658dc95183b6572": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1740worker # [ 8.714759] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1741worker # [ 8.721140] systemd[1]: nscd.service: Deactivated successfully.1742worker # [ 8.727240] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1743worker # [ 8.731125] systemd[1]: nscd.service: Consumed 17ms CPU time over 362ms wall clock time, 6.8M memory peak, 5.5M read from disk.1744hub # [ 12.009357] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1745hub # [ 12.011292] tailscaled[618]: dns: using "openresolv" mode1746worker # [ 8.756111] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1747hub # [ 12.019512] tailscaled[618]: dns: using dns.openresolvManager1748worker # [ 8.776950] systemd[1]: Finished resolvconf update.1749worker # [ 8.778405] systemd[1]: linger-users.service: Deactivated successfully.1750worker # [ 8.784139] systemd[1]: Finished linger-users.service.1751worker # [ 8.793542] systemd[1]: Reached target Preparation for Network.1752worker # [ 8.802923] systemd[1]: Starting DHCP Client...1753worker # [ 8.807396] nsncd[584]: Jul 13 09:40:06.040 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1754worker # [ 8.816646] systemd[1]: Starting Address configuration of eth1...1755worker # [ 9.063868] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31756worker # [ 8.828344] systemd[1]: Starting Extra networking commands....1757hub # [ 12.093706] nginx-pre-start[692]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok1758worker # [ 8.839356] systemd[1]: Starting Tailscale node agent...1759hub # [ 12.099137] nginx-pre-start[692]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful1760worker # [ 8.850156] systemd[1]: Started Name Service Cache Daemon (nsncd).1761hub # [ 12.116976] systemd[1]: Started Nginx Web Server.1762worker # [ 8.863128] systemd[1]: Reached target Host and Network Name Lookups.1763worker # [ 8.864774] systemd[1]: Reached target User and Group Name Lookups.1764worker # [ 8.915896] network-addresses-eth1-start[600]: adding address 192.168.1.2/24... done1765hub # [ 12.097422] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1766worker # [ 8.938146] network-addresses-eth1-start[600]: adding address 2001:db8:1::2/64... done1767worker # [ 8.967076] systemd[1]: Finished Address configuration of eth1.1768hub # [ 12.098374] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41769hub # [ 12.163665] cfg80211: Loading compiled-in X.509 certificates for regulatory database1770worker # [ 9.260006] rtc_cmos 00:05: RTC can wake from S41771worker # [ 9.276004] ACPI: button: Power Button [PWRF]1772hub # [ 12.251764] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1773hub # [ 12.251925] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1774hub # [ 12.312769] systemd[1]: Starting Virtual Console Setup...1775hub # [ 12.253970] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21776hub # [ 12.253978] cfg80211: failed to load regulatory.db1777hub # [ 12.265546] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61778hub # [ 12.265988] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51779hub # [ 12.418139] Console: switching to colour dummy device 80x251780hub # [ 12.598244] [drm] Found bochs VGA, ID 0xb0c5.1781hub # [ 12.598247] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1782hub # [ 12.601133] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1783hub # [ 12.620942] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01784worker # [ 9.123304] dhcpcd[623]: dhcpcd-10.3.2 starting1785worker # [ 9.127742] systemd[1]: Finished Extra networking commands..1786worker # [ 9.133134] systemd[1]: Reached target Network.1787worker # [ 9.134665] dhcpcd[665]: dev: loaded udev1788worker # [ 9.146114] systemd[1]: Starting Permit User Sessions...1789worker # [ 9.387883] mousedev: PS/2 mouse device common for all mice1790worker # [ 9.390502] 8021q: 802.1Q VLAN Support v1.81791worker # [ 9.391573] 8021q: adding VLAN 0 to HW filter on device eth11792hub # [ 12.645924] fbcon: bochs-drmdrmfb (fb0) is primary device1793worker # [ 9.409330] rtc_cmos 00:05: registered as rtc01794worker # [ 9.414791] parport_pc 00:03: reported by Plug and Play ACPI1795hub # [ 12.669208] Console: switching to colour frame buffer device 160x501796worker # [ 9.418313] Floppy drive(s): fd0 is 2.88M AMI BIOS1797hub # [ 12.681598] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1798worker # [ 9.422065] rtc_cmos 00:05: setting system clock to 2026-07-13T09:40:06 UTC (1783935606)1799worker # [ 9.207259] systemd[1]: Finished Permit User Sessions.1800worker # [ 9.219501] systemd[1]: Started Getty on tty1.1801worker # [ 9.220784] systemd[1]: Reached target Login Prompts.1802hub # [ 12.486812] systemd[1]: Started Tailscale node agent.1803worker # [ 9.225920] tailscaled[602]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1804hub # [ 12.489193] tailscaled[618]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1805worker # [ 9.472368] FDC 0 is a S82078B1806worker # [ 9.236848] tailscaled[602]: logtail started1807worker # [ 9.238100] tailscaled[602]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}1808worker # [ 9.243281] tailscaled[602]: LogID: a9b463678bb5b65ca84b58e010480d4bc1926eae5131ef762a34e1ede58a10161809worker # [ 9.245368] tailscaled[602]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1810worker # [ 9.247765] tailscaled[602]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1811worker # [ 9.251055] tailscaled[602]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1812worker # [ 9.495970] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1813hub # [ 12.768479] tun: Universal TUN/TAP device driver, 1.61814worker # [ 9.508558] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1815hub # [ 12.775354] kvm_amd: TSC scaling supported1816worker # [ 9.274115] tailscaled[602]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:58857->[::1]:53: read: connection refused (in 12ms), trying bootstrap...1817hub # [ 12.776680] kvm_amd: Nested Virtualization enabled1818hub # [ 12.779574] kvm_amd: Nested Paging enabled1819hub # [ 12.783800] kvm_amd: LBR virtualization supported1820worker # [ 9.283110] tailscaled[602]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ...1821hub # [ 12.785470] kvm_amd: Virtual VMLOAD VMSAVE supported1822hub # [ 12.788376] kvm_amd: Virtual GIF supported1823worker # [ 9.285645] tailscaled[602]: bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 18.230.97.74:443: connect: network is unreachable1824hub # [ 12.789732] kvm_amd: Virtual NMI enabled1825worker # [ 9.296774] tailscaled[602]: trying bootstrapDNS("derp10.tailscale.com", "2001:19f0:8001:2d9:5400:2ff:feef:bbb1") for "log.tailscale.com" ...1826worker # [ 9.300427] dbus-broker-launch[530]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1827worker # [ 9.307785] tailscaled[602]: bootstrapDNS("derp10.tailscale.com", "2001:19f0:8001:2d9:5400:2ff:feef:bbb1") for "log.tailscale.com" error: Get "https://derp10.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:8001:2d9:5400:2ff:feef:bbb1]:443: connect: network is unreachable1828worker # [ 9.313112] tailscaled[602]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ...1829worker # [ 9.320207] tailscaled[602]: bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 104.248.8.210:443: connect: network is unreachable1830worker # [ 9.328112] tailscaled[602]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ...1831hub # [ 12.592241] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1832hub # [ 12.594363] tailscaled[618]: dns: using "openresolv" mode1833worker # [ 9.330732] tailscaled[602]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable1834worker # [ 9.335902] tailscaled[602]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ...1835worker # [ 9.338266] tailscaled[602]: bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" error: Get "https://derp10.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 137.220.36.168:443: connect: network is unreachable1836worker # [ 9.345131] tailscaled[602]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ...1837hub # [ 12.613293] tailscaled[618]: dns: using dns.openresolvManager1838worker # [ 9.349207] tailscaled[602]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2401:c080:1000:467f:5400:2ff:feee:22aa]:443: connect: network is unreachable1839hub # [ 12.615569] tailscaled[618]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true}1840worker # [ 9.358226] tailscaled[602]: trying bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" ...1841worker # [ 9.364108] tailscaled[602]: bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.77.138:443: connect: network is unreachable1842hub # [ 12.631626] tailscaled[618]: magicsock: disco key = d:2a3dc5d3af0b735e1843worker # [ 9.372124] tailscaled[602]: trying bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" ...1844hub # [ 12.634141] tailscaled[618]: Creating WireGuard device...1845hub # [ 12.638384] tailscaled[618]: Bringing WireGuard device up...1846worker # [ 9.374747] tailscaled[602]: bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:6001]:443: connect: network is unreachable1847worker # [ 9.379645] tailscaled[602]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ...1848worker # [ 9.382065] tailscaled[602]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable1849worker # [ 9.389130] tailscaled[602]: trying bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" ...1850worker # [ 9.391694] tailscaled[602]: bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::ec1:e001]:443: connect: network is unreachable1851worker # [ 9.396588] tailscaled[602]: trying bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" ...1852hub # [ 12.658558] tailscaled[618]: Bringing router up...1853hub # [ 12.660877] tailscaled[618]: router: using firewall mode pref1854worker # [ 9.398948] tailscaled[602]: bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 165.22.33.71:443: connect: network is unreachable1855worker # [ 9.404337] tailscaled[602]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ...1856hub # [ 12.667736] tailscaled[618]: external route: up1857hub # [ 12.669427] tailscaled[618]: router: portUpdate(port=41641, network=udp6)1858worker # [ 9.413214] tailscaled[602]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable1859worker # [ 9.419173] tailscaled[602]: logtail: upload: log upload of 476 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/98d9495f9a6cd78a11a9d2601493c59363927510f41e6f00cf5446f7e39ecb6e": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1860hub # [ 12.927538] EDAC MC: Ver: 3.0.01861worker # [ 9.667961] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1862worker # [ 9.437099] tailscaled[602]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1863worker # [ 9.438985] tailscaled[602]: dns: using "openresolv" mode1864worker # [ 9.441388] tailscaled[602]: dns: using dns.openresolvManager1865worker # [ 9.683063] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01866hub # [ 12.724979] tailscaled[618]: router: default choosing iptables1867hub # [ 12.776391] tailscaled[618]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1868hub # [ 12.785079] tailscaled[618]: Clearing router settings...1869hub # [ 12.786834] tailscaled[618]: Starting network monitor...1870hub # [ 12.791327] tailscaled[618]: Engine created.1871hub # [ 12.803325] tailscaled[618]: router: portUpdate(port=41641, network=udp4)1872hub # [ 12.820664] systemd-logind[538]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1873hub # [ 12.823822] tailscaled[618]: pm: migrating "_daemon" profile to new format1874hub # [ 13.065427] ppdev: user-space parallel port driver1875hub # [ 12.828145] tailscaled[618]: envknob: PORT="41641"1876hub # [ 12.829453] systemd-logind[538]: Watching system buttons on /dev/input/event2 (Power Button)1877hub # [ 12.834890] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1878hub # [ 12.838817] tailscaled[618]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1879hub # [ 12.845473] tailscaled[618]: got LocalBackend in 359ms1880hub # [ 12.848290] tailscaled[618]: Start1881hub # [ 12.849374] tailscaled[618]: ipnext: "conn25": skipping extension1882hub # [ 12.851507] tailscaled[618]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop1883hub # [ 12.859222] tailscaled[618]: profile data directory: profile not found1884hub # [ 12.862610] tailscaled[618]: Backend: logs: be:9e31a15b69986d70ea3409418b77416e2da4de2f74523017bc51d1b750aa0d0e fe:1885hub # [ 12.866378] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1886hub # [ 12.868919] tailscaled[618]: blockEngineUpdates(true)1887worker # [ 9.612264] dhcpcd[665]: eth0: waiting for carrier1888hub # [ 12.872438] tailscaled[618]: health(warnable=wantrunning-false): error: Tailscale is stopped.1889worker # [ 9.613790] dhcpcd[665]: eth0: carrier acquired1890hub # [ 12.876487] tailscaled[618]: wgengine: Reconfig: configuring router1891hub # [ 12.879258] tailscaled[618]: wgengine: Reconfig: user dialer1892hub # [ 12.880700] tailscaled[618]: wgengine: Reconfig: configuring DNS1893hub # [ 12.882818] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1894worker # [ 9.624860] dhcpcd[665]: DUID 00:01:00:01:31:e7:6e:f6:52:54:00:12:34:561895hub # [ 12.885225] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1896worker # [ 9.626796] dhcpcd[665]: eth0: IAID 00:12:34:561897hub # [ 12.887895] tailscaled[618]: dns: OScfg: {}1898worker # [ 9.628752] dhcpcd[665]: eth0: adding address fe80::5054:ff:fe12:34561899hub # [ 12.903060] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1900worker # [ 9.643348] systemd[1]: Started Tailscale node agent.1901worker # [ 9.644770] tailscaled[602]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1902worker # [ 9.680643] tailscaled[602]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1903worker # [ 9.685109] tailscaled[602]: dns: using "openresolv" mode1904worker # [ 9.692342] tailscaled[602]: dns: using dns.openresolvManager1905worker # [ 9.696095] tailscaled[602]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true}1906worker # [ 9.701059] tailscaled[602]: magicsock: disco key = d:1d7639e9dd6ae01c1907worker # [ 9.703264] tailscaled[602]: Creating WireGuard device...1908worker # [ 9.704786] tailscaled[602]: Bringing WireGuard device up...1909worker # [ 9.708199] tailscaled[602]: Bringing router up...1910worker # [ 9.709446] tailscaled[602]: router: using firewall mode pref1911hub # [ 12.973372] (udev-worker)[761]: Network interface NamePolicy= disabled on kernel command line.1912worker # [ 9.721101] tailscaled[602]: router: portUpdate(port=41641, network=udp6)1913worker # [ 9.722749] tailscaled[602]: external route: up1914hub # [ 12.986539] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1915hub # [ 12.991455] systemd[1]: Stopped Virtual Console Setup.1916hub # [ 13.003467] systemd[1]: Starting Virtual Console Setup...1917worker # [ 9.743101] tailscaled[602]: router: default choosing iptables1918worker # [ 9.743328] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1919worker # [ 9.764952] tailscaled[602]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1920worker # [ 9.770867] tailscaled[602]: router: portUpdate(port=41641, network=udp4)1921worker # [ 9.773251] tailscaled[602]: Clearing router settings...1922worker # [ 9.774855] tailscaled[602]: Starting network monitor...1923worker # [ 9.777277] tailscaled[602]: Engine created.1924worker # [ 9.787087] tailscaled[602]: pm: migrating "_daemon" profile to new format1925worker # [ 9.790225] tailscaled[602]: envknob: PORT="41641"1926worker # [ 9.791468] tailscaled[602]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1927worker # [ 9.793292] tailscaled[602]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1928hub # [ 13.057810] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1929worker # [ 9.798176] tailscaled[602]: got LocalBackend in 156ms1930hub # [ 13.060630] systemd[1]: Stopped Virtual Console Setup.1931worker # [ 9.800247] tailscaled[602]: Start1932worker # [ 9.802407] tailscaled[602]: ipnext: "conn25": skipping extension1933worker # [ 9.804372] tailscaled[602]: ipnext: active extensions: posture, clientupdate, relayserver, taildrop, conn25, portlist1934worker # [ 9.790165] cfg80211: Loading compiled-in X.509 certificates for regulatory database1935worker # [ 9.797032] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1936hub # [ 13.070954] systemd[1]: Starting Virtual Console Setup...1937worker # [ 9.813318] tailscaled[602]: profile data directory: profile not found1938worker # [ 9.814915] tailscaled[602]: Backend: logs: be:a9b463678bb5b65ca84b58e010480d4bc1926eae5131ef762a34e1ede58a1016 fe:1939worker # [ 9.817238] tailscaled[602]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1940worker # [ 9.819322] tailscaled[602]: blockEngineUpdates(true)1941worker # [ 9.822355] tailscaled[602]: health(warnable=wantrunning-false): error: Tailscale is stopped.1942hub # [ 13.083226] systemd-logind[538]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1943worker # [ 9.824332] tailscaled[602]: wgengine: Reconfig: configuring router1944worker # [ 9.825868] tailscaled[602]: wgengine: Reconfig: user dialer1945worker # [ 9.827273] tailscaled[602]: wgengine: Reconfig: configuring DNS1946worker # [ 9.829932] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1947worker # [ 9.832227] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1948worker # [ 9.834080] tailscaled[602]: dns: OScfg: {}1949worker # [ 9.797144] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1950worker # [ 9.797336] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21951hub # [ 13.371422] 8021q: adding VLAN 0 to HW filter on device eth01952hub # [ 13.135560] dhcpcd[680]: eth0: waiting for carrier1953hub # [ 13.138260] dhcpcd[680]: eth0: carrier acquired1954hub # [ 13.150463] dhcpcd[680]: DUID 00:01:00:01:31:e7:6e:f7:52:54:00:12:34:561955hub # [ 13.152138] dhcpcd[680]: eth0: IAID 00:12:34:561956hub # [ 13.154176] dhcpcd[680]: eth0: adding address fe80::5054:ff:fe12:34561957worker # [ 9.905129] systemd[1]: Starting Virtual Console Setup...1958worker # [ 9.797343] cfg80211: failed to load regulatory.db1959worker # [ 9.848282] 8021q: adding VLAN 0 to HW filter on device eth01960worker # [ 9.892283] tun: Universal TUN/TAP device driver, 1.61961worker # [ 9.895241] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41962worker # [ 9.917341] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61963worker # [ 9.917730] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51964worker # [ 9.997436] Console: switching to colour dummy device 80x251965worker # [ 10.222794] ppdev: user-space parallel port driver1966worker # [ 10.290238] [drm] Found bochs VGA, ID 0xb0c5.1967worker # [ 10.290241] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1968worker # [ 9.945736] systemd-logind[534]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1969worker # [ 10.057280] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1970worker # [ 10.061331] systemd-logind[534]: Watching system buttons on /dev/input/event2 (Power Button)1971worker # [ 10.065535] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line.1972worker # [ 10.067820] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1973worker # [ 10.071931] systemd[1]: Stopped Virtual Console Setup.1974worker # [ 10.079134] systemd[1]: Starting Virtual Console Setup...1975hub # [ 13.356343] dhcpcd[680]: eth0: soliciting a DHCP lease1976worker # [ 10.335970] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1977hub # [ 13.614368] NET: Registered PF_PACKET protocol family1978worker # [ 10.114505] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1979hub # [ 13.380585] dhcpcd[680]: eth0: offered 10.0.2.15 from 10.0.2.21980hub # [ 13.384262] dhcpcd[680]: eth0: probing address 10.0.2.15/241981worker # [ 10.363266] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01982worker # [ 10.381025] fbcon: bochs-drmdrmfb (fb0) is primary device1983worker # [ 10.407436] Console: switching to colour frame buffer device 160x501984worker # [ 10.418779] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1985worker # [ 10.184250] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1986worker # [ 10.187434] systemd[1]: Stopped Virtual Console Setup.1987worker # [ 10.197856] systemd[1]: Starting Virtual Console Setup...1988hub # [ 13.466791] systemd-vconsole-setup[787]: Configuration of first virtual console was skipped, ignoring remaining ones.1989hub # [ 13.472376] systemd[1]: Finished Virtual Console Setup.1990worker # [ 10.245418] systemd-vconsole-setup[737]: Configuration of first virtual console was skipped, ignoring remaining ones.1991worker # [ 10.253846] systemd[1]: Finished Virtual Console Setup.1992worker # [ 10.514283] kvm_amd: TSC scaling supported1993worker # [ 10.515160] kvm_amd: Nested Virtualization enabled1994worker # [ 10.516400] kvm_amd: Nested Paging enabled1995worker # [ 10.517361] kvm_amd: LBR virtualization supported1996worker # [ 10.518477] kvm_amd: Virtual VMLOAD VMSAVE supported1997worker # [ 10.519557] kvm_amd: Virtual GIF supported1998worker # [ 10.520521] kvm_amd: Virtual NMI enabled1999worker # [ 10.549657] EDAC MC: Ver: 3.0.02000worker # [ 11.027610] dhcpcd[665]: eth0: soliciting a DHCP lease2001worker # [ 11.281168] NET: Registered PF_PACKET protocol family2002worker # [ 11.049285] dhcpcd[665]: eth0: offered 10.0.2.15 from 10.0.2.22003worker # [ 11.053475] dhcpcd[665]: eth0: probing address 10.0.2.15/242004worker # [ 12.339575] dhcpcd[665]: eth0: soliciting an IPv6 router2005worker # [ 12.345929] dhcpcd[665]: eth0: Router Advertisement from fe80::22006worker # [ 12.350824] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2542007worker # [ 12.357952] dhcpcd[665]: eth0: adding address fec0::5054:ff:fe12:3456/642008worker # [ 12.362887] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2542009worker # [ 12.368767] dhcpcd[665]: eth0: adding route to fec0::/642010worker # [ 12.373658] dhcpcd[665]: eth0: adding default route via fe80::22011worker # [ 12.381791] tailscaled[602]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed]2012worker # [ 12.403363] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2013worker # [ 12.408210] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2014worker # [ 12.411854] tailscaled[602]: dns: OScfg: {}2015worker # [ 12.425415] tailscaled[602]: wgengine: set DNS config again after major link change2016worker # [ 12.429116] tailscaled[602]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64]2017worker # [ 12.431984] tailscaled[602]: magicsock: 0 active derp conns2018worker # [ 12.433412] tailscaled[602]: router: portUpdate(port=41641, network=udp6)2019worker # [ 12.435091] tailscaled[602]: router: portUpdate(port=41641, network=udp4)2020hub # [ 15.891386] dhcpcd[680]: eth0: soliciting an IPv6 router2021hub # [ 15.897646] dhcpcd[680]: eth0: Router Advertisement from fe80::22022hub # [ 15.902605] dhcpcd[680]: eth0: adding address fec0::5054:ff:fe12:3456/642023hub # [ 15.909708] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2542024hub # [ 15.914786] dhcpcd[680]: eth0: adding route to fec0::/642025hub # [ 15.919853] dhcpcd[680]: eth0: adding default route via fe80::22026hub # [ 15.924913] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2542027hub # [ 15.936583] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] rebind-reason=[default-if-changed]2028hub # [ 15.955486] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2029hub # [ 15.958709] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2030hub # [ 15.960501] tailscaled[618]: dns: OScfg: {}2031hub # [ 16.007127] tailscaled[618]: wgengine: set DNS config again after major link change2032hub # [ 16.009725] tailscaled[618]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64]2033hub # [ 16.012843] tailscaled[618]: magicsock: 0 active derp conns2034hub # [ 16.014988] tailscaled[618]: router: portUpdate(port=41641, network=udp6)2035hub # [ 16.016649] tailscaled[618]: router: portUpdate(port=41641, network=udp4)2036hub # [ 17.009641] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::e212:692:9bba:3031/128, gw=, outif=2, table=2552037worker # [ 13.873452] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552038worker # [ 14.388260] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::1d03:d858:fe9d:404e/128, gw=, outif=2, table=2552039hub # [ 17.714645] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552040hub # [ 18.487650] dhcpcd[680]: eth0: leased 10.0.2.15 for 86400 seconds2041hub # [ 18.495412] dhcpcd[680]: eth0: adding route to 10.0.2.0/242042hub # [ 18.498722] dhcpcd[680]: eth0: adding default route via 10.0.2.22043hub # [ 18.502869] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552044hub # [ 18.505902] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552045hub # [ 18.508621] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542046hub # [ 18.511484] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542047hub # [ 18.619710] systemd[1]: Started DHCP Client.2048hub # [ 18.623298] systemd[1]: Reached target Network is Online.2049hub # [ 18.628914] systemd[1]: Started headscale coordination server for Tailscale.2050hub # [ 18.631247] systemd[1]: Reached target Multi-User System.2051hub # [ 18.633584] systemd[1]: Startup finished in 973ms (kernel) + 5.421s (initrd) + 12.237s (userspace) = 18.632s.2052hub: (finished: waiting for unit headscale, in 16.47 seconds)2053hub: waiting for TCP port 443 on localhost2054worker # [ 15.612845] dhcpcd[665]: eth0: leased 10.0.2.15 for 86400 seconds2055worker # [ 15.618910] dhcpcd[665]: eth0: adding route to 10.0.2.0/242056hub # Connection to localhost (::1) 443 port [tcp/https] succeeded!2057hub: (finished: waiting for TCP port 443 on localhost, in 0.07 seconds)2058hub: waiting for unit tailscaled2059worker # [ 15.628233] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552060worker # [ 15.634579] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552061worker # [ 15.642427] dhcpcd[665]: eth0: adding default route via 10.0.2.22062worker # [ 15.646392] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542063worker # [ 15.651860] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542064hub # [ 18.952183] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64] rebind-reason=[ips-changed]2065worker # [ 15.711698] systemd[1]: Started DHCP Client.2066worker # [ 15.715381] systemd[1]: Reached target Multi-User System.2067hub # [ 18.976156] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2068worker # [ 15.717302] systemd[1]: Startup finished in 973ms (kernel) + 4.633s (initrd) + 10.110s (userspace) = 15.717s.2069hub # [ 18.979330] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2070hub # [ 18.981090] tailscaled[618]: dns: OScfg: {}2071hub: (finished: waiting for unit tailscaled, in 0.10 seconds)2072worker: waiting for unit tailscaled2073worker: waiting for the VM to finish booting2074worker: Guest shell says: b'Spawning backdoor root shell...\n'2075worker: connected to guest root shell2076worker: (connecting took 0.00 seconds)2077worker: (finished: waiting for the VM to finish booting, in 0.00 seconds)2078worker: (finished: waiting for unit tailscaled, in 0.02 seconds)2079hub: must succeed: headscale users create test2080hub # [ 19.015553] headscale-start[897]: 2026-07-13T09:40:13Z WRN2081hub # [ 19.018486] headscale-start[897]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed.2082hub # [ 19.027774] headscale-start[897]: 2026-07-13T09:40:13Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key2083hub # [ 19.032771] tailscaled[618]: wgengine: set DNS config again after major link change2084hub # [ 19.035160] headscale-start[897]: 2026-07-13T09:40:13Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite2085hub # [ 19.041132] tailscaled[618]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::e212:692:9bba:3031/64]2086hub # [ 19.044171] tailscaled[618]: magicsock: 0 active derp conns2087hub # [ 19.047482] tailscaled[618]: router: portUpdate(port=41641, network=udp6)2088hub # [ 19.049275] tailscaled[618]: router: portUpdate(port=41641, network=udp4)2089hub # [ 19.051468] tailscaled[618]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2090hub # [ 19.056857] tailscaled[618]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152091hub # [ 19.162408] headscale-start[897]: 2026-07-13T09:40:13Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key2092hub # [ 19.173099] headscale-start[897]: 2026-07-13T09:40:13Z INF starting headscale commit=v0.29.2 version=0.29.22093hub # [ 19.175522] headscale-start[897]: 2026-07-13T09:40:13Z INF Clients with a lower minimum version will be rejected minimum_version=v1.802094hub # [ 19.178810] headscale-start[897]: 2026-07-13T09:40:13Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:144 > derp region: {RegionID:999 RegionCode: RegionName: Latitude:0 Longitude:0 Avoid:false NoMeasureNoHome:false Nodes:[0x1c23d8028120]}2095hub # [ 19.183823] headscale-start[897]: 2026-07-13T09:40:13Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:145 > derp nodes[0]: &{Name:999 RegionID:999 HostName:hub CertName: IPv4: IPv6: STUNPort:3478 STUNOnly:false DERPPort:443 InsecureForTests:false STUNTestIP: CanPort80:false}2096hub # [ 19.192880] headscale-start[897]: 2026-07-13T09:40:13Z INF HA subnet router health probing enabled interval=10000 timeout=50002097hub # [ 19.198838] headscale-start[897]: 2026-07-13T09:40:13Z INF stun server started at [::]:34782098hub # [ 19.203404] headscale-start[897]: 2026-07-13T09:40:13Z WRN listening without TLS but ServerURL does not start with http://2099hub # [ 19.207489] headscale-start[897]: 2026-07-13T09:40:13Z INF listening and serving HTTP on: 127.0.0.1:80802100hub # [ 19.209711] headscale-start[897]: 2026-07-13T09:40:13Z INF metrics server disabled (metrics_listen_addr is empty)2101worker # [ 16.401731] tailscaled[602]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed]2102worker # [ 16.436328] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2103worker # [ 16.441371] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2104worker # [ 16.446814] tailscaled[602]: dns: OScfg: {}2105worker # [ 16.465738] tailscaled[602]: wgengine: set DNS config again after major link change2106worker # [ 16.468748] tailscaled[602]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1d03:d858:fe9d:404e/64 fec0::5054:ff:fe12:3456/64]2107worker # [ 16.471845] tailscaled[602]: magicsock: 0 active derp conns2108worker # [ 16.475321] tailscaled[602]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152109worker # [ 16.478381] tailscaled[602]: router: portUpdate(port=41641, network=udp6)2110worker # [ 16.483579] tailscaled[602]: router: portUpdate(port=41641, network=udp4)2111worker # [ 16.485224] tailscaled[602]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2112hub # [ 20.187816] headscale-start[897]: 2026-07-13T09:40:14Z INF user created user.name=test2113hub: (finished: must succeed: headscale users create test, in 1.19 seconds)2114hub: must succeed: headscale preauthkeys -u 1 create --reusable2115hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.13 seconds)2116hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname hub2117hub # [ 20.390746] tailscaled[618]: localapi: [POST] /localapi/v0/check-prefs2118hub # [ 20.393785] tailscaled[618]: localapi: [POST] /localapi/v0/start2119hub # [ 20.395686] tailscaled[618]: Start2120hub # [ 20.397448] tailscaled[618]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="hub" update=check Persist=nil}, reason: [opts.UpdatePrefs]2121hub # [ 20.401758] tailscaled[618]: generating new machine key2122hub # [ 20.407706] tailscaled[618]: machine key written to store2123hub # [ 20.409380] tailscaled[618]: profile data directory: profile not found2124hub # [ 20.412824] tailscaled[618]: Backend: logs: be:9e31a15b69986d70ea3409418b77416e2da4de2f74523017bc51d1b750aa0d0e fe:2125hub # [ 20.420244] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2126hub # [ 20.423192] tailscaled[618]: blockEngineUpdates(true)2127hub # [ 20.424466] tailscaled[618]: Reconfig(down): no changes made to Engine config2128hub # [ 20.427475] tailscaled[618]: localapi: [POST] /localapi/v0/login-interactive2129hub # [ 20.429571] tailscaled[618]: StartLoginInteractiveAs("root"): url=false2130hub # [ 20.431449] tailscaled[618]: control: client.Login(2)2131hub # [ 20.435328] tailscaled[618]: control: LoginInteractive -> regen=true2132hub # [ 20.437709] tailscaled[618]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2133hub # [ 20.440269] tailscaled[618]: control: client.Shutdown ...2134hub # [ 20.442212] tailscaled[618]: control: doLogin(regen=true, hasUrl=false)2135hub # [ 20.444258] tailscaled[618]: health(warnable=wantrunning-false): ok2136hub # [ 20.446322] tailscaled[618]: control: mapRoutine: exiting2137hub # [ 20.448932] tailscaled[618]: control: authRoutine: exiting2138hub # [ 20.450309] tailscaled[618]: control: updateRoutine: exiting2139hub # [ 20.452338] tailscaled[618]: control: Client.Shutdown done.2140hub # [ 20.524334] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2141hub # [ 20.540890] headscale-start[897]: 2026-07-13T09:40:14Z INF http request bytes=176 elapsed=3.114921 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:34622 status=2002142hub # [ 20.548332] tailscaled[618]: control: control server key from https://hub: ts2021=[8N0DL], legacy=2143hub # [ 20.551408] tailscaled[618]: control: Generating a new nodekey.2144hub # [ 20.555661] tailscaled[618]: control: RegisterReq: onode= node=[H1abq] fup=false nks=false2145hub # [ 21.179318] headscale-start[897]: 2026-07-13T09:40:15Z INF http request bytes=249 elapsed=599.275327 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:34632 status=2002146hub # [ 21.189823] tailscaled[618]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2147hub # [ 21.204196] tailscaled[618]: blockEngineUpdates(false)2148hub # [ 21.686697] headscale-start[897]: 2026-07-13T09:40:15Z INF http request bytes=0 elapsed=483.431274 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=2002149hub # [ 22.184401] headscale-start[897]: 2026-07-13T09:40:16Z INF node connected machine.key=[iJu9q] node.expired=false node.id=1 node.is_tagged=false node.key=[H1abq] node.name=hub node.online=true user.name=test2150hub # [ 22.197582] headscale-start[897]: 2026-07-13T09:40:16Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x1c23d810ea80 component=poll machine.key=[iJu9q] node.expired=false node.id=1 node.is_tagged=false node.key=[H1abq] node.name=hub node.online=false omit_peers=false stream=true user.name=test2151hub # [ 22.257551] tailscaled[618]: health(warnable=not-in-map-poll): ok2152hub # [ 22.276336] tailscaled[618]: active login: test2153hub # [ 22.284782] tailscaled[618]: netmap: suggested exit node: no preferred DERP, try again later2154hub # [ 22.286774] tailscaled[618]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2155hub # [ 22.290448] tailscaled[618]: magicsock: SetPrivateKey called (init)2156hub # [ 22.292526] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers)2157hub # [ 22.299176] tailscaled[618]: wgengine: Reconfig: configuring router2158hub # [ 22.535584] tailscaled[618]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [14ms] (forced=false)2159hub # [ 22.539109] tailscaled[618]: magicsock: home is now derp-999 ()2160hub # [ 22.542236] tailscaled[618]: magicsock: endpoints changed: 127.0.0.1:41641 (stun), [2001:db8:1::1]:41641 (stun), 10.0.2.15:41641 (local), 192.168.1.1:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::e212:692:9bba:3031]:41641 (local)2161hub # [ 22.547630] tailscaled[618]: magicsock: adding connection to derp-999 for home-keep-alive2162hub # [ 22.550288] tailscaled[618]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2163hub # [ 22.552752] tailscaled[618]: derphttp.Client.Connect: connecting to derp-999 ()2164hub # [ 22.558973] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2165hub # [ 22.574280] tailscaled[618]: magicsock: derp-999 connected; connGen=12166hub # [ 22.783417] tailscaled[618]: router: enabling connmark-based rp_filter workaround2167hub # [ 22.879179] tailscaled[618]: wgengine: Reconfig: user dialer2168hub # [ 22.881616] tailscaled[618]: tsdial: bart table size: 22169hub # [ 22.883276] tailscaled[618]: wgengine: Reconfig: configuring DNS2170hub # [ 22.885201] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1}2171hub # [ 22.932618] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa}2172hub # [ 22.935324] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2173hub # [ 23.016890] systemd[1]: Stopped target Host and Network Name Lookups.2174hub # [ 23.020808] systemd[1]: Stopping Host and Network Name Lookups...2175hub # [ 23.022908] systemd[1]: Stopped target User and Group Name Lookups.2176hub # [ 23.025554] systemd[1]: Stopping User and Group Name Lookups...2177hub # [ 23.028151] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2178hub # [ 23.030085] systemd[1]: nscd.service: Deactivated successfully.2179hub # [ 23.034493] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2180hub # [ 23.043230] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2181hub # [ 23.072741] tailscaled[618]: peerapi: serving on http://100.64.0.1:584362182hub # [ 23.076272] tailscaled[618]: peerapi: serving on http://[fd7a:115c:a1e0::1]:597802183hub # [ 23.081672] tailscaled[618]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2184hub # [ 23.089959] tailscaled[618]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2185hub # [ 23.098116] systemd[1]: Started Name Service Cache Daemon (nsncd).2186hub # [ 23.100647] tailscaled[618]: netmap: suggested exit node: ()2187hub # [ 23.107391] tailscaled[618]: writing netmap to disk cache2188hub # [ 23.109419] nsncd[1043]: Jul 13 09:40:17.224 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2189hub # [ 23.113787] systemd[1]: Reached target Host and Network Name Lookups.2190hub # [ 23.116210] systemd[1]: Reached target User and Group Name Lookups.2191hub # [ 23.118199] tailscaled[618]: health(warnable=no-derp-connection): ok2192hub # [ 23.119958] tailscaled[618]: health(warnable=no-derp-connection): ok2193hub # [ 23.121800] tailscaled[618]: health(warnable=warming-up): ok2194hub # [ 23.123717] tailscaled[618]: [RATELIMIT] format("health(warnable=%s): ok")2195hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname hub, in 2.80 seconds)2196worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname tt-worker2197hub # [ 23.187369] headscale-start[897]: 2026-07-13T09:40:17Z INF http request bytes=0 elapsed=90.369027 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=2002198worker # [ 19.932872] tailscaled[602]: localapi: [POST] /localapi/v0/check-prefs2199worker # [ 19.935345] tailscaled[602]: localapi: [POST] /localapi/v0/start2200worker # [ 19.937129] tailscaled[602]: Start2201worker # [ 19.938374] tailscaled[602]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="tt-worker" update=check Persist=nil}, reason: [opts.UpdatePrefs]2202worker # [ 19.942686] tailscaled[602]: generating new machine key2203worker # [ 19.947203] tailscaled[602]: machine key written to store2204worker # [ 19.948908] tailscaled[602]: profile data directory: profile not found2205worker # [ 19.951215] tailscaled[602]: Backend: logs: be:a9b463678bb5b65ca84b58e010480d4bc1926eae5131ef762a34e1ede58a1016 fe:2206worker # [ 19.954082] tailscaled[602]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2207worker # [ 19.957130] tailscaled[602]: blockEngineUpdates(true)2208worker # [ 19.958426] tailscaled[602]: Reconfig(down): no changes made to Engine config2209worker # [ 19.961089] tailscaled[602]: control: client.Shutdown ...2210worker # [ 19.962425] tailscaled[602]: control: mapRoutine: exiting2211worker # [ 19.964868] tailscaled[602]: control: authRoutine: exiting2212worker # [ 19.966555] tailscaled[602]: control: updateRoutine: exiting2213worker # [ 19.968436] tailscaled[602]: control: Client.Shutdown done.2214worker # [ 19.970090] tailscaled[602]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2215worker # [ 19.972686] tailscaled[602]: health(warnable=wantrunning-false): ok2216worker # [ 19.975082] tailscaled[602]: localapi: [POST] /localapi/v0/login-interactive2217worker # [ 19.977049] tailscaled[602]: StartLoginInteractiveAs("root"): url=false2218worker # [ 19.978920] tailscaled[602]: control: client.Login(2)2219worker # [ 19.982472] tailscaled[602]: control: LoginInteractive -> regen=true2220worker # [ 19.984719] tailscaled[602]: control: doLogin(regen=true, hasUrl=false)2221worker # [ 20.011098] tailscaled[602]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2222hub # [ 23.278910] headscale-start[897]: 2026-07-13T09:40:17Z INF http request bytes=176 elapsed=0.222654 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:35938 status=2002223worker # [ 20.029095] tailscaled[602]: control: control server key from https://hub: ts2021=[8N0DL], legacy=2224worker # [ 20.031195] tailscaled[602]: control: Generating a new nodekey.2225worker # [ 20.034282] tailscaled[602]: control: RegisterReq: onode= node=[i9SxN] fup=false nks=false2226hub # [ 23.690303] headscale-start[897]: 2026-07-13T09:40:17Z INF http request bytes=0 elapsed=494.862336 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=2002227hub # [ 23.988567] tailscaled[618]: netmap: suggested exit node: ()2228hub # [ 23.997862] tailscaled[618]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2229hub # [ 24.010207] tailscaled[618]: netmap: suggested exit node: ()2230hub # [ 24.195312] headscale-start[897]: 2026-07-13T09:40:18Z INF http request bytes=249 elapsed=877.72608 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:35940 status=2002231worker # [ 20.935978] tailscaled[602]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2232worker # [ 20.953623] tailscaled[602]: blockEngineUpdates(false)2233hub # [ 24.692721] headscale-start[897]: 2026-07-13T09:40:18Z INF http request bytes=0 elapsed=469.824796 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35940 status=2002234hub # [ 24.797500] tailscaled[618]: netmap: suggested exit node: ()2235hub # [ 24.809691] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2236hub # [ 24.816908] tailscaled[618]: wgengine: Reconfig: configuring router2237hub # [ 24.823845] tailscaled[618]: wgengine: Reconfig: user dialer2238hub # [ 24.828798] tailscaled[618]: tsdial: bart table size: 42239hub # [ 24.834890] tailscaled[618]: wgengine: Reconfig: configuring DNS2240hub # [ 24.838447] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2241hub # [ 24.906679] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2242hub # [ 24.909428] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2243hub # [ 24.962451] tailscaled[618]: netmap: suggested exit node: ()2244hub # [ 24.964580] tailscaled[618]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)")2245hub # [ 25.058115] tailscaled[618]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2246hub # [ 25.195907] headscale-start[897]: 2026-07-13T09:40:19Z INF node connected machine.key=[QfUS0] node.expired=false node.id=2 node.is_tagged=false node.key=[i9SxN] node.name=tt-worker node.online=true user.name=test2247hub # [ 25.211625] headscale-start[897]: 2026-07-13T09:40:19Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x1c23d80dbb20 component=poll machine.key=[QfUS0] node.expired=false node.id=2 node.is_tagged=false node.key=[i9SxN] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test2248hub # [ 25.230606] headscale-start[897]: 2026-07-13T09:40:19Z INF http request bytes=0 elapsed=144.511104 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34632 status=2002249worker # [ 21.994791] tailscaled[602]: health(warnable=not-in-map-poll): ok2250worker # [ 22.023130] tailscaled[602]: active login: test2251worker # [ 22.036453] tailscaled[602]: netmap: suggested exit node: no preferred DERP, try again later2252worker # [ 22.043767] tailscaled[602]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2253worker # [ 22.058572] tailscaled[602]: magicsock: SetPrivateKey called (init)2254worker # [ 22.061570] tailscaled[602]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2255worker # [ 22.066586] tailscaled[602]: wgengine: Reconfig: configuring router2256worker # [ 22.208634] tailscaled[602]: router: enabling connmark-based rp_filter workaround2257worker # [ 22.232745] tailscaled[602]: wgengine: Reconfig: user dialer2258worker # [ 22.234705] tailscaled[602]: tsdial: bart table size: 42259worker # [ 22.235990] tailscaled[602]: wgengine: Reconfig: configuring DNS2260worker # [ 22.237475] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2261worker # [ 22.256170] tailscaled[602]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2262worker # [ 22.258713] tailscaled[602]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2263worker # [ 22.299820] systemd[1]: Stopped target Host and Network Name Lookups.2264worker # [ 22.304390] systemd[1]: Stopping Host and Network Name Lookups...2265worker # [ 22.306536] tailscaled[602]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [16ms] (forced=false)2266worker # [ 22.308810] tailscaled[602]: magicsock: home is now derp-999 ()2267worker # [ 22.311238] systemd[1]: Stopped target User and Group Name Lookups.2268worker # [ 22.313208] tailscaled[602]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::1d03:d858:fe9d:404e]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local)2269worker # [ 22.318588] systemd[1]: Stopping User and Group Name Lookups...2270worker # [ 22.320196] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2271worker # [ 22.323456] systemd[1]: nscd.service: Deactivated successfully.2272worker # [ 22.326186] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2273worker # [ 22.330873] tailscaled[602]: magicsock: adding connection to derp-999 for home-keep-alive2274worker # [ 22.332874] tailscaled[602]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2275worker # [ 22.335170] tailscaled[602]: derphttp.Client.Connect: connecting to derp-999 ()2276worker # [ 22.348624] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2277worker # [ 22.351200] tailscaled[602]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2278worker # [ 22.364116] tailscaled[602]: magicsock: derp-999 connected; connGen=12279worker # [ 22.371405] tailscaled[602]: peerapi: serving on http://100.64.0.2:465902280worker # [ 22.374439] tailscaled[602]: peerapi: serving on http://[fd7a:115c:a1e0::2]:471662281worker # [ 22.379605] tailscaled[602]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2282worker # [ 22.382956] tailscaled[602]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2283worker # [ 22.390099] tailscaled[602]: writing netmap to disk cache2284worker # [ 22.393282] tailscaled[602]: health(warnable=no-derp-connection): ok2285worker # [ 22.395807] systemd[1]: Started Name Service Cache Daemon (nsncd).2286worker # [ 22.398305] systemd[1]: Reached target Host and Network Name Lookups.2287worker # [ 22.400754] nsncd[921]: Jul 13 09:40:19.714 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2288worker # [ 22.405840] tailscaled[602]: health(warnable=no-derp-connection): ok2289worker # [ 22.407770] systemd[1]: Reached target User and Group Name Lookups.2290worker # [ 22.410698] tailscaled[602]: health(warnable=no-derp-connection): ok2291worker # [ 22.412600] tailscaled[602]: [RATELIMIT] format("health(warnable=%s): ok")2292worker # [ 22.415604] tailscaled[602]: netmap: suggested exit node: ()2293worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-1ijb1zyUX_ij-GNJG28BthfP8dtXKdQNZuTmxJ77yLQfnwhQ-nj4_6tR1RwTRFAHFmYUh4T988pzS --hostname tt-worker, in 2.55 seconds)2294worker: waiting for success: tailscale ping hub2295hub # [ 25.697308] headscale-start[897]: 2026-07-13T09:40:19Z INF http request bytes=0 elapsed=51.560463 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35940 status=2002296worker # [ 22.449639] tailscaled[602]: localapi: [POST] /localapi/v0/ping2297worker # [ 22.451674] tailscaled[602]: ping(100.64.0.1): sending disco ping to [H1abq] hub ...2298worker # [ 22.460862] tailscaled[602]: magicsock: disco: node [H1abq] d:2a3dc5d3af0b735e now using 192.168.1.1:41641 mtu=1360 tx=20d5ec6718872299worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds)2300hub: must succeed: tailscale ip -42301hub: (finished: must succeed: tailscale ip -4, in 0.06 seconds)2302worker: 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.toml2303worker: (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)2304hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub2305hub # [ 25.843429] systemd[1]: Starting tribuchet-hub.socket...2306hub # [ 25.853907] systemd[1]: Listening on tribuchet-hub.socket.2307hub # [ 25.859555] systemd[1]: Starting tribuchet-hub.service...2308hub # [ 25.931557] tribuchet[1086]: 2026-07-13T09:40:20.047573Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[]2309hub # [ 25.937616] tribuchet[1086]: 2026-07-13T09:40:20.055849Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers2310hub # [ 25.942655] tribuchet[1086]: 2026-07-13T09:40:20.060719Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true2311hub # [ 25.950701] tribuchet[1086]: 2026-07-13T09:40:20.068751Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock2312hub # [ 25.955963] systemd[1]: Started tribuchet-hub.service.2313hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.16 seconds)2314worker: must succeed: systemctl start tribuchet-worker2315worker # [ 22.758355] systemd[1]: Starting tribuchet-worker.service...2316worker # [ 22.852140] exec[962]: 2026-07-13T09:40:20.167908Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false }2317worker # [ 22.864626] exec[962]: 2026-07-13T09:40:20.181127Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service2318worker # [ 22.872090] exec[965]: 2026-07-13T09:40:20.187629Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false }2319worker # [ 22.886648] exec[965]: 2026-07-13T09:40:20.203261Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox")2320worker # [ 22.894049] systemd[1]: Started tribuchet-worker.service.2321worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.20 seconds)2322hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"'2323hub # [ 26.187131] tailscaled[618]: magicsock: disco: node [i9SxN] d:1d7639e9dd6ae01c now using 192.168.1.2:41641 mtu=1360 tx=5c72ee3c10b12324hub # [ 26.210534] headscale-start[897]: 2026-07-13T09:40:20Z INF http request bytes=0 elapsed=498.42005 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35940 status=2002325hub # [ 26.248975] tribuchet[1086]: 2026-07-13T09:40:20.367131Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }]2326hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 0.11 seconds)2327subtest: a build dispatches over the tailnet2328hub: must succeed: echo tailscale-auth-payload > /root/payload2329hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.02 seconds)2330hub: must succeed: nix-store --add /root/payload2331worker # [ 23.020712] exec[965]: 2026-07-13T09:40:20.336992Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"]2332worker # [ 23.127930] tailscaled[602]: netmap: suggested exit node: ()2333worker # [ 23.137233] tailscaled[602]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2334worker # [ 23.144245] tailscaled[602]: netmap: suggested exit node: ()2335hub: (finished: must succeed: nix-store --add /root/payload, in 0.14 seconds)2336hub: must succeed: cat > /root/test.nix << 'EOF'2337let2338 bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9";2339 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2340in derivation {2341 name = "tt-tailscale";2342 system = "x86_64-linux";2343 builder = bash + "/bin/bash";2344 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2345}2346EOF2347hub: (finished: must succeed: cat > /root/test.nix << 'EOF'2348let2349 bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9";2350 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2351in derivation {2352 name = "tt-tailscale";2353 system = "x86_64-linux";2354 builder = bash + "/bin/bash";2355 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2356}2357EOF, in 0.03 seconds)2358hub: must succeed: nix-build /root/test.nix --no-out-link2359hub # this derivation will be built:2360hub # /nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv2361hub # building '/nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv'...2362hub # [ 26.725659] tribuchet[1086]: 2026-07-13T09:40:20.844040Z INFO tribuchet::hub::submit: queueing build id="7bc54b05ab43aba55f0a6c1d36b59574" system="x86_64-linux"2363hub # [ 26.730808] tribuchet[1086]: 2026-07-13T09:40:20.849174Z INFO tribuchet::hub: dispatching build id="7bc54b05ab43aba55f0a6c1d36b59574" worker="tt-worker"2364hub # tribuchet: building on tt-worker2365worker # [ 23.477940] exec[965]: 2026-07-13T09:40:20.794259Z INFO tribuchet::worker: build assigned id="7bc54b05ab43aba55f0a6c1d36b59574"2366worker # [ 23.495964] systemd[1]: Started Nix Daemon.2367worker # [ 23.557717] nix-daemon[967]: accepted connection from pid 965, user tribuchet (trusted)2368worker # [ 23.564571] exec[965]: 2026-07-13T09:40:20.881177Z INFO harmonia_store_remote::client: Client Version is 1.38, server version is 1.38 version=ProtocolVersion(1, 38) server_version=ProtocolVersion(1, 38) features={}2369worker # [ 23.570443] exec[965]: 2026-07-13T09:40:20.886872Z INFO harmonia_store_remote::client: Nix Version "2.34.8" version="2.34.8"2370hub # [ 26.838383] tribuchet[1086]: 2026-07-13T09:40:20.956235Z INFO tribuchet::hub::relay: input path negotiation done id="7bc54b05ab43aba55f0a6c1d36b59574" total=8 missing=12371hub # [ 26.858510] systemd[1]: Started Nix Daemon.2372hub # [ 26.974158] nix-daemon[1115]: accepted connection from pid 1086, user root (trusted)2373hub # [ 26.984233] tribuchet[1086]: 2026-07-13T09:40:21.102018Z INFO harmonia_store_remote::client: Client Version is 1.38, server version is 1.38 version=ProtocolVersion(1, 38) server_version=ProtocolVersion(1, 38) features={}2374hub # [ 26.989990] tribuchet[1086]: 2026-07-13T09:40:21.108358Z INFO harmonia_store_remote::client: Nix Version "2.34.8+2" version="2.34.8+2"2375worker # [ 23.802608] systemd[1]: Starting tribuchet-sandboxd.service...2376worker # [ 23.847375] tribuchet-sandboxd[973]: 2026-07-13T09:40:21.163764Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock2377worker # [ 23.852298] systemd[1]: Started tribuchet-sandboxd.service.2378worker # [ 23.855106] tribuchet-sandboxd[973]: 2026-07-13T09:40:21.171071Z INFO tribuchet_sandboxd: leased build="7bc54b05ab43aba55f0a6c1d36b59574" base=1325400064 uid_count=12379worker # [ 23.859799] exec[965]: 2026-07-13T09:40:21.171184Z INFO tribuchet::worker::build: leased sandbox build_id="7bc54b05ab43aba55f0a6c1d36b59574" pool_base=1325400064 uid_count=12380worker # [ 23.864791] exec[965]: 2026-07-13T09:40:21.181408Z INFO tribuchet::worker::build: sandbox network decision id="7bc54b05ab43aba55f0a6c1d36b59574" fixed_output=false network=false net_isolation=false2381worker # [ 24.278578] exec[965]: 2026-07-13T09:40:21.593014Z INFO tribuchet::worker::build: builder finished id="7bc54b05ab43aba55f0a6c1d36b59574" exit_code=02382worker # [ 24.299279] exec[965]: 2026-07-13T09:40:21.614887Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="7bc54b05ab43aba55f0a6c1d36b59574"2383worker # [ 24.329291] exec[965]: 2026-07-13T09:40:21.645674Z INFO tribuchet::worker::resume: build result acknowledged id="7bc54b05ab43aba55f0a6c1d36b59574"2384hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 1.17 seconds)2385hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale2386hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale, in 0.03 seconds)2387hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build'2388hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.03 seconds)2389worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished'2390worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.04 seconds)2391(finished: subtest: a build dispatches over the tailnet, in 1.45 seconds)2392subtest: a non-tailnet peer is rejected2393worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml2394worker # [ 24.457366] tribuchet-sandboxd[973]: 2026-07-13T09:40:21.773624Z INFO tribuchet_sandboxd: released build="7bc54b05ab43aba55f0a6c1d36b59574" base=13254000642395worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.02 seconds)2396worker: must succeed: systemctl restart tribuchet-worker2397worker # [ 24.496101] exec[965]: 2026-07-13T09:40:21.811159Z INFO tribuchet::worker: handover requested; exiting2398worker # [ 24.500443] systemd[1]: Stopping tribuchet-worker.service...2399hub # [ 27.764424] tribuchet[1086]: 2026-07-13T09:40:21.882227Z INFO tribuchet::hub: worker disconnected worker="tt-worker"2400worker # [ 24.698762] systemd[1]: tribuchet-worker.service: Deactivated successfully.2401worker # [ 24.707354] systemd[1]: Stopped tribuchet-worker.service.2402worker # [ 24.711862] systemd[1]: tribuchet-worker.service: Consumed 86ms CPU time over 1.946s wall clock time, 18.7M memory peak, 14.3M read from disk, 4K written to disk, 3.9K incoming IP traffic, 2.1K outgoing IP traffic.2403worker # [ 24.738106] systemd[1]: Starting tribuchet-worker.service...2404worker # [ 24.789381] exec[999]: 2026-07-13T09:40:22.105288Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false }2405worker # [ 24.802609] exec[999]: 2026-07-13T09:40:22.119118Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service2406worker # [ 24.809400] exec[1002]: 2026-07-13T09:40:22.125597Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false }2407worker # [ 24.820509] exec[1002]: 2026-07-13T09:40:22.137113Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox")2408worker # [ 24.827985] systemd[1]: Started tribuchet-worker.service.2409worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.35 seconds)2410hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed'2411hub # [ 28.464876] tribuchet[1086]: 2026-07-13T09:40:22.581983Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:439862412worker # [ 25.216264] exec[1002]: 2026-07-13T09:40:22.532558Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2413worker # [ 25.227725] exec[1002]: 2026-07-13T09:40:22.532649Z INFO tribuchet::worker: reconnecting to hub in 1s2414worker # [ 25.460694] tailscaled[602]: magicsock: disco: node [H1abq] d:2a3dc5d3af0b735e now using [2001:db8:1::1]:41641 mtu=1360 tx=11691e690cac2415hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.12 seconds)2416(finished: subtest: a non-tailnet peer is rejected, in 1.49 seconds)2417(finished: run the VM test script, in 30.32 seconds)2418test script finished in 30.41s2419cleanup2420kill QemuMachine (pid 47)2421hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14)2422kill QemuMachine (pid 48)2423worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14)2424(finished: cleanup, in 0.33 seconds)2425additionally exposed symbols:2426 hub, worker,2427 vlan1,2428 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