vm-test-run-tribuchet-tailscale
x86_64-linux.nixos-test-tailscale
· build #116
· 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 # Disk image does not exist, creating the virtualisation disk image...11hub: QEMU running (pid 47)12hub # Formatting '/build/vm-state-hub/tmp.NWXN8r3HEL', 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: 58b665c3-e498-4264-b597-c08ba8d7ce3a17hub # 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/sak6fic7mv49rnksnpn03rmr73vi5khs-nixos-system-hub-test/init regInfo=/nix/store/d4srjnks1vcn9dwxyf2pc5wbqd24idd0-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 552916433 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.000813] 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.002755] found SMP MP-table at [mem 0x000f5470-0x000f547f]66hub # [ 0.002766] Using GB pages for direct mapping67hub # [ 0.002864] RAMDISK: [mem 0x7e302000-0x7ffcffff]68hub # [ 0.002872] ACPI: Early table checksum verification disabled69hub # [ 0.002875] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )70hub # [ 0.002879] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)71hub # [ 0.002890] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)72hub # [ 0.002897] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)73hub # [ 0.002899] ACPI: FACS 0x000000007FFE0000 00004074hub # [ 0.002901] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)75hub # [ 0.002902] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)76hub # [ 0.002904] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)77hub # [ 0.002905] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]78hub # [ 0.002906] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]79hub # [ 0.002907] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]80hub # [ 0.002907] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]81hub # [ 0.002908] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]82hub # [ 0.002908] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]83hub # [ 0.003383] No NUMA configuration found84hub # [ 0.003384] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff]85hub # [ 0.003388] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff]86hub # [ 0.005896] Zone ranges:87hub # [ 0.005897] DMA [mem 0x0000000000001000-0x0000000000ffffff]88hub # [ 0.005899] DMA32 [mem 0x0000000001000000-0x000000007ffdafff]89hub # [ 0.005900] Normal empty90hub # [ 0.005901] Device empty91hub # [ 0.005902] Movable zone start for each node92hub # [ 0.005903] Early memory node ranges93hub # [ 0.005903] node 0: [mem 0x0000000000001000-0x000000000009efff]94hub # [ 0.005904] node 0: [mem 0x0000000000100000-0x000000007ffdafff]95hub # [ 0.005905] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff]96hub # [ 0.005929] On node 0, zone DMA: 1 pages in unavailable ranges97hub # [ 0.006220] On node 0, zone DMA: 97 pages in unavailable ranges98hub # [ 0.044937] On node 0, zone DMA32: 37 pages in unavailable ranges99hub # [ 0.045919] ACPI: PM-Timer IO Port: 0x608100hub # [ 0.045934] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])101hub # [ 0.045967] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23102hub # [ 0.045970] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)103hub # [ 0.045972] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)104hub # [ 0.045973] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)105hub # [ 0.045973] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)106hub # [ 0.045974] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)107hub # [ 0.045977] ACPI: Using ACPI (MADT) for SMP configuration information108hub # [ 0.045978] ACPI: HPET id: 0x8086a201 base: 0xfed00000109hub # [ 0.045982] TSC deadline timer available110hub # [ 0.045987] CPU topo: Max. logical packages: 1111hub # [ 0.045987] CPU topo: Max. logical dies: 1112hub # [ 0.045988] CPU topo: Max. dies per package: 1113hub # [ 0.045991] CPU topo: Max. threads per core: 1114hub # [ 0.045992] CPU topo: Num. cores per package: 1115hub # [ 0.045992] CPU topo: Num. threads per package: 1116hub # [ 0.045992] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs117hub # [ 0.046014] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()118hub # [ 0.046052] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]119hub # [ 0.046054] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]120hub # [ 0.046055] [mem 0x80000000-0xfeffbfff] available for PCI devices121hub # [ 0.046057] Booting paravirtualized kernel on KVM122hub # [ 0.046059] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns123hub # [ 0.050503] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1124hub # [ 0.053151] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152125hub # [ 0.053199] kvm-guest: PV spinlocks disabled, single CPU126hub # [ 0.053201] 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/sak6fic7mv49rnksnpn03rmr73vi5khs-nixos-system-hub-test/init regInfo=/nix/store/d4srjnks1vcn9dwxyf2pc5wbqd24idd0-closure-info/registration console=ttyS0,115200n8 console=tty0127hub # [ 0.053297] Unknown kernel command line parameters "regInfo=/nix/store/d4srjnks1vcn9dwxyf2pc5wbqd24idd0-closure-info/registration", will be passed to user space.128hub # [ 0.053310] random: crng init done129hub # [ 0.053311] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes130hub # [ 0.055730] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)131hub # [ 0.055752] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)132hub # [ 0.055789] Fallback order for Node 0: 0133hub # [ 0.055792] Built 1 zonelists, mobility grouping on. Total pages: 524153134hub # [ 0.055793] Policy zone: DMA32135hub # [ 0.058463] mem auto-init: stack:all(zero), heap alloc:on, heap free:off136hub # [ 0.062467] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1137hub # [ 0.067621] allocated 4194304 bytes of page_ext138hub # [ 0.077721] ftrace: allocating 48598 entries in 192 pages139hub # [ 0.077724] ftrace: allocated 192 pages with 2 groups140hub # [ 0.078690] Dynamic Preempt: lazy141hub # [ 0.078873] rcu: Preemptible hierarchical RCU implementation.142hub # [ 0.078874] rcu: RCU event tracing is enabled.143hub # [ 0.078875] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.144hub # [ 0.078877] Trampoline variant of Tasks RCU enabled.145hub # [ 0.078877] Rude variant of Tasks RCU enabled.146hub # [ 0.078878] Tracing variant of Tasks RCU enabled.147hub # [ 0.078879] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.148hub # [ 0.078889] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1149hub # [ 0.078918] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.150hub # [ 0.078919] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.151hub # [ 0.078920] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.152hub # [ 0.083368] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16153hub # [ 0.083653] rcu: srcu_init: Setting srcu_struct sizes based on contention.154hub # [ 0.083771] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)155hub # [ 0.090966] Console: colour VGA+ 80x25156hub # [ 0.090970] printk: legacy console [tty0] enabled157hub # [ 0.131346] printk: legacy console [ttyS0] enabled158hub # [ 0.314808] ACPI: Core revision 20250807159hub # [ 0.316349] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns160hub # [ 0.319153] APIC: Switch to symmetric I/O mode setup161hub # [ 0.320856] x2apic enabled162hub # [ 0.322074] APIC: Switched APIC routing to: physical x2apic163hub # [ 0.324876] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1164hub # [ 0.326686] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns165hub # [ 0.329720] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018)166hub # [ 0.331837] x86/cpu: User Mode Instruction Prevention (UMIP) activated167hub # [ 0.332881] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127168hub # [ 0.334718] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0169hub # [ 0.335723] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto170hub # [ 0.337719] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl171hub # [ 0.339720] Transient Scheduler Attacks: Mitigation: Clear CPU buffers172hub # [ 0.340719] Spectre V2 : Mitigation: Enhanced / Automatic IBRS173hub # [ 0.341719] Speculative Return Stack Overflow: Mitigation: Safe RET174hub # [ 0.342718] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization175hub # [ 0.344724] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier176hub # [ 0.345719] active return thunk: srso_alias_return_thunk177hub # [ 0.347746] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'178hub # [ 0.349718] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'179hub # [ 0.351718] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'180hub # [ 0.353718] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'181hub # [ 0.354718] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'182hub # [ 0.355718] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'183hub # [ 0.357717] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'184hub # [ 0.358718] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'185hub # [ 0.359718] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'186hub # [ 0.360719] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256187hub # [ 0.362719] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64188hub # [ 0.363718] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512189hub # [ 0.365718] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024190hub # [ 0.367718] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8191hub # [ 0.368718] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16192hub # [ 0.369718] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24193hub # [ 0.370718] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.194hub # [ 0.406430] Freeing SMP alternatives memory: 44K195hub # [ 0.407720] pid_max: default: 32768 minimum: 301196hub # [ 0.408822] LSM: initializing lsm=capability,landlock,yama,bpf,ima197hub # [ 0.409840] landlock: Up and running.198hub # [ 0.410719] Yama: becoming mindful.199hub # [ 0.412755] LSM support for eBPF active200hub # [ 0.413839] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)201hub # [ 0.414769] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)202hub # [ 0.417552] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)203hub # [ 0.418287] Performance Events: Fam17h+ core perfctr, AMD PMU driver.204hub # [ 0.418723] ... version: 2205hub # [ 0.419720] ... bit width: 48206hub # [ 0.420778] ... generic counters: 6207hub # [ 0.421720] ... generic bitmap: 000000000000003f208hub # [ 0.422720] ... fixed-purpose counters: 0209hub # [ 0.423720] ... fixed-purpose bitmap: 0000000000000000210hub # [ 0.424720] ... value mask: 0000ffffffffffff211hub # [ 0.425720] ... max period: 00007fffffffffff212hub # [ 0.426720] ... global_ctrl mask: 000000000000003f213hub # [ 0.427843] signal: max sigframe size: 3376214hub # [ 0.428896] rcu: Hierarchical SRCU implementation.215hub # [ 0.429724] rcu: Max phase no-delay instances is 400.216hub # [ 0.435340] smp: Bringing up secondary CPUs ...217hub # [ 0.435737] smp: Brought up 1 node, 1 CPU218hub # [ 0.436723] smpboot: Total of 1 processors activated (4800.03 BogoMIPS)219hub # [ 0.437943] Memory: 1969248K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved)220hub # [ 0.439055] devtmpfs: initialized221hub # [ 0.439965] x86/mm: Memory block size: 128MB222hub # [ 0.441870] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns223hub # [ 0.442753] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)224hub # [ 0.443750] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).225hub # [ 0.444817] pinctrl core: initialized pinctrl subsystem226hub # [ 0.446087] PM: RTC time: 09:23:55, date: 2026-07-13227hub # [ 0.449581] NET: Registered PF_NETLINK/PF_ROUTE protocol family228hub # [ 0.451264] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations229hub # [ 0.451769] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations230hub # [ 0.453018] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations231hub # [ 0.453733] audit: initializing netlink subsys (disabled)232hub # [ 0.455042] thermal_sys: Registered thermal governor 'fair_share'233hub # [ 0.455044] thermal_sys: Registered thermal governor 'bang_bang'234hub # [ 0.455724] audit: type=2000 audit(1783934635.236:1): state=initialized audit_enabled=0 res=1235hub # [ 0.457723] thermal_sys: Registered thermal governor 'step_wise'236hub # [ 0.457725] thermal_sys: Registered thermal governor 'user_space'237hub # [ 0.458720] thermal_sys: Registered thermal governor 'power_allocator'238hub # [ 0.459751] cpuidle: using governor menu239hub # [ 0.462892] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5240hub # [ 0.464056] PCI: Using configuration type 1 for base access241hub # [ 0.464720] PCI: Using configuration type 1 for extended access242hub # [ 0.465973] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.243hub # [ 0.472738] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages244hub # [ 0.473721] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page245hub # [ 0.478720] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages246hub # [ 0.479721] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page247hub # [ 0.491004] ACPI: Added _OSI(Module Device)248hub # [ 0.491721] ACPI: Added _OSI(Processor Device)249hub # [ 0.493740] ACPI: Added _OSI(Processor Aggregator Device)250hub # [ 0.498591] ACPI: 1 ACPI AML tables successfully acquired and loaded251hub # [ 0.504950] ACPI: Interpreter enabled252hub # [ 0.505739] ACPI: PM: (supports S0 S3 S4 S5)253hub # [ 0.506722] ACPI: Using IOAPIC for interrupt routing254hub # [ 0.507741] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug255hub # [ 0.510720] PCI: Using E820 reservations for host bridge windows256hub # [ 0.511884] ACPI: Enabled 2 GPEs in block 00 to 0F257hub # [ 0.520246] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])258hub # [ 0.520728] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]259hub # [ 0.522084] acpiphp: Slot [3] registered260hub # [ 0.522792] acpiphp: Slot [4] registered261hub # [ 0.523831] acpiphp: Slot [5] registered262hub # [ 0.524765] acpiphp: Slot [6] registered263hub # [ 0.525761] acpiphp: Slot [7] registered264hub # [ 0.526762] acpiphp: Slot [8] registered265hub # [ 0.527779] acpiphp: Slot [9] registered266hub # [ 0.528762] acpiphp: Slot [10] registered267hub # [ 0.529762] acpiphp: Slot [11] registered268hub # [ 0.530779] acpiphp: Slot [12] registered269hub # [ 0.531762] acpiphp: Slot [13] registered270hub # [ 0.532753] acpiphp: Slot [14] registered271hub # [ 0.533754] acpiphp: Slot [15] registered272hub # [ 0.534769] acpiphp: Slot [16] registered273hub # [ 0.535754] acpiphp: Slot [17] registered274hub # [ 0.536753] acpiphp: Slot [18] registered275hub # [ 0.537762] acpiphp: Slot [19] registered276hub # [ 0.538780] acpiphp: Slot [20] registered277hub # [ 0.539754] acpiphp: Slot [21] registered278hub # [ 0.540753] acpiphp: Slot [22] registered279hub # [ 0.541753] acpiphp: Slot [23] registered280hub # [ 0.542767] acpiphp: Slot [24] registered281hub # [ 0.543754] acpiphp: Slot [25] registered282hub # [ 0.544753] acpiphp: Slot [26] registered283hub # [ 0.545767] acpiphp: Slot [27] registered284hub # [ 0.546753] acpiphp: Slot [28] registered285hub # [ 0.547784] acpiphp: Slot [29] registered286hub # [ 0.548754] acpiphp: Slot [30] registered287hub # [ 0.549776] acpiphp: Slot [31] registered288hub # [ 0.550742] PCI host bridge to bus 0000:00289hub # [ 0.551727] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]290hub # [ 0.552721] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]291hub # [ 0.553721] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]292hub # [ 0.554722] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]293hub # [ 0.555721] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]294hub # [ 0.556722] pci_bus 0000:00: root bus resource [bus 00-ff]295hub # [ 0.558067] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint296hub # [ 0.559633] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint297hub # [ 0.561625] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint298hub # [ 0.564561] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]299hub # [ 0.565785] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk300hub # [ 0.566721] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk301hub # [ 0.567721] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk302hub # [ 0.568721] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk303hub # [ 0.570134] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint304hub # [ 0.571785] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]305hub # [ 0.573958] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint306hub # [ 0.575333] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI307hub # [ 0.576735] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB308hub # [ 0.578144] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint309hub # [ 0.580802] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]310hub # [ 0.581752] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]311hub # [ 0.582773] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]312hub # [ 0.583969] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]313hub # [ 0.585829] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint314hub # [ 0.588738] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]315hub # [ 0.589735] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]316hub # [ 0.590792] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]317hub # [ 0.591735] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]318hub # [ 0.594869] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint319hub # [ 0.597455] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]320hub # [ 0.598735] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]321hub # [ 0.599773] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]322hub # [ 0.602796] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint323hub # [ 0.604747] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]324hub # [ 0.605735] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]325hub # [ 0.606773] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]326hub # [ 0.609721] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint327hub # [ 0.611735] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]328hub # [ 0.613739] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]329hub # [ 0.614773] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]330hub # [ 0.617734] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint331hub # [ 0.620739] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]332hub # [ 0.621735] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]333hub # [ 0.622773] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]334hub # [ 0.625703] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint335hub # [ 0.628749] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]336hub # [ 0.629736] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]337hub # [ 0.630772] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]338hub # [ 0.634320] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint339hub # [ 0.637593] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]340hub # [ 0.638735] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]341hub # [ 0.639773] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]342hub # [ 0.640735] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]343hub # [ 0.643773] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint344hub # [ 0.645748] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]345hub # [ 0.646782] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]346hub # [ 0.649734] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint347hub # [ 0.652515] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]348hub # [ 0.653736] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]349hub # [ 0.654772] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]350hub # [ 0.657760] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint351hub # [ 0.660227] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]352hub # [ 0.660736] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]353hub # [ 0.661773] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]354hub # [ 0.670105] ACPI: PCI: Interrupt link LNKA configured for IRQ 10355hub # [ 0.670930] ACPI: PCI: Interrupt link LNKB configured for IRQ 10356hub # [ 0.671917] ACPI: PCI: Interrupt link LNKC configured for IRQ 11357hub # [ 0.672908] ACPI: PCI: Interrupt link LNKD configured for IRQ 11358hub # [ 0.673832] ACPI: PCI: Interrupt link LNKS configured for IRQ 9359hub # [ 0.676148] iommu: Default domain type: Translated360hub # [ 0.676731] iommu: DMA domain TLB invalidation policy: lazy mode361hub # [ 0.678037] ACPI: bus type USB registered362hub # [ 0.678778] usbcore: registered new interface driver usbfs363hub # [ 0.679764] usbcore: registered new interface driver hub364hub # [ 0.680731] usbcore: registered new device driver usb365hub # [ 0.682686] NetLabel: Initializing366hub # [ 0.683542] NetLabel: domain hash size = 128367hub # [ 0.684720] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO368hub # [ 0.685825] NetLabel: unlabeled traffic allowed by default369hub # [ 0.686736] PCI: Using ACPI for IRQ routing370hub # [ 0.688385] pci 0000:00:02.0: vgaarb: setting as boot VGA device371hub # [ 0.688715] pci 0000:00:02.0: vgaarb: bridge control possible372hub # [ 0.688715] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none373hub # [ 0.688723] vgaarb: loaded374hub # [ 0.689894] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0375hub # [ 0.690720] hpet0: 3 comparators, 64-bit 100.000000 MHz counter376hub # [ 0.695806] clocksource: Switched to clocksource kvm-clock377hub # [ 0.698036] VFS: Disk quotas dquot_6.6.0378hub # [ 0.701315] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)379hub # [ 0.703561] pnp: PnP ACPI init380hub # [ 0.705247] pnp: PnP ACPI: found 6 devices381hub # [ 0.713584] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns382hub # [ 0.716092] clocksource: Switched to clocksource acpi_pm383hub # [ 0.717817] NET: Registered PF_INET protocol family384hub # [ 0.719715] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)385hub # [ 0.738572] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)386hub # [ 0.741229] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)387hub # [ 0.743498] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)388hub # [ 0.745859] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)389hub # [ 0.748122] TCP: Hash tables configured (established 16384 bind 16384)390hub # [ 0.750148] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)391hub # [ 0.752357] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)392hub # [ 0.754298] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)393hub # [ 0.756415] NET: Registered PF_UNIX/PF_LOCAL protocol family394hub # [ 0.758120] NET: Registered PF_XDP protocol family395hub # [ 0.759636] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]396hub # [ 0.761427] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]397hub # [ 0.763223] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]398hub # [ 0.765204] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]399hub # [ 0.767181] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]400hub # [ 0.769309] pci 0000:00:01.0: PIIX3: Enabling Passive Release401hub # [ 0.771026] pci 0000:00:00.0: Limiting direct PCI/PCI transfers402hub # [ 0.774414] ACPI: \_SB_.LNKD: Enabled at IRQ 11403hub # [ 0.777810] PCI: CLS 0 bytes, default 64404hub # [ 0.779342] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns405hub # [ 0.782294] Trying to unpack rootfs image as initramfs...406hub # [ 0.830782] Initialise system trusted keyrings407hub # [ 0.835293] workingset: timestamp_bits=40 max_order=19 bucket_order=0408hub # [ 0.860513] Key type asymmetric registered409hub # [ 0.861812] Asymmetric key parser 'x509' registered410hub # [ 0.867154] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)411hub # [ 0.872168] io scheduler mq-deadline registered412hub # [ 0.876109] io scheduler kyber registered413hub # [ 0.879689] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled414hub # [ 0.881873] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A415hub # [ 0.891274] Linux agpgart interface v0.103416hub # [ 0.892640] ACPI: bus type drm_connector registered417hub # [ 0.896625] usbcore: registered new interface driver usbserial_generic418hub # [ 0.898535] usbserial: USB Serial support registered for generic419hub # [ 0.903111] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.420hub # [ 0.903111] Please enable it if your BIOS has the CPPC option.421hub # [ 0.907022] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled422hub # [ 0.915258] drop_monitor: Initializing network drop monitor service423hub # [ 0.917289] NET: Registered PF_INET6 protocol family424hub # [ 0.923645] Segment Routing with IPv6425hub # [ 0.928118] In-situ OAM (IOAM) with IPv6426hub # [ 0.929768] IPI shorthand broadcast: enabled427hub # [ 0.938517] sched_clock: Marking stable (699029066, 239054984)->(1124714875, -186630825)428hub # [ 0.945195] registered taskstats version 1429hub # [ 0.946749] Loading compiled-in X.509 certificates430hub # [ 0.971111] Demotion targets for Node 0: null431hub # [ 0.972665] Key type .fscrypt registered432hub # [ 0.975110] Key type fscrypt-provisioning registered433hub # [ 0.976738] ima: No TPM chip found, activating TPM-bypass!434hub # [ 0.982121] ima: Allocated hash algorithm: sha1435hub # [ 0.983564] ima: No architecture policies found436hub # [ 0.989104] PM: Magic number: 2:758:373437hub # [ 0.990402] vc vcsa1: hash matches438hub # [ 0.994004] RAS: Correctable Errors collector initialized.439hub # [ 1.005038] clk: Disabling unused clocks440hub # [ 1.008105] PM: genpd: Disabling unused power domains441hub # [ 1.163867] Freeing initrd memory: 29496K442hub # [ 1.167840] Freeing unused decrypted memory: 2028K443hub # [ 1.171407] Freeing unused kernel image (initmem) memory: 3636K444hub # [ 1.173288] Write protecting the kernel read-only data: 32768k445hub # [ 1.176047] Freeing unused kernel image (text/rodata gap) memory: 1272K446hub # [ 1.178611] Freeing unused kernel image (rodata/data gap) memory: 796K447hub # [ 1.231803] x86/mm: Checked W+X mappings: passed, no W+X pages found.448hub # [ 1.233759] Run /init as init process449hub # [ 1.245573] systemd[1]: Inserted module 'autofs4'450hub # [ 1.262804] fuse: init (API version 7.45)451hub # [ 1.270254] ACPI: \_SB_.LNKC: Enabled at IRQ 10452hub # [ 1.278908] ACPI: \_SB_.LNKA: Enabled at IRQ 10453hub # [ 1.283601] ACPI: \_SB_.LNKB: Enabled at IRQ 11454hub # [ 1.328191] systemd[1]: Successfully made /usr/ read-only.455hub # [ 1.667936] 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)456hub # [ 1.689350] systemd[1]: Detected virtualization kvm.457hub # [ 1.693229] systemd[1]: Detected architecture x86-64.458hub # [ 1.697157] systemd[1]: Running in initrd.459hub # [ 1.701343] systemd[1]: Initializing machine ID from random generator.460hub # [ 1.706439] systemd[1]: Hostname set to <hub>.461hub # [ 1.931830] systemd[1]: bpf-restrict-fs: LSM BPF program attached462hub # [ 1.992906] systemd[1]: Queued start job for default target Initrd Default Target.463hub # [ 1.998753] systemd[1]: Created slice Slice /system/modprobe.464hub # [ 2.000809] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.465hub # [ 2.003257] systemd[1]: Expecting device /dev/disk/by-label/nixos...466hub # [ 2.005213] systemd[1]: Reached target Path Units.467hub # [ 2.006781] systemd[1]: Reached target Slice Units.468hub # [ 2.008381] systemd[1]: Reached target Swaps.469hub # [ 2.009810] systemd[1]: Reached target Timer Units.470hub # [ 2.011605] systemd[1]: Listening on D-Bus System Message Bus Socket.471hub # [ 2.013707] systemd[1]: Listening on Journal Socket (/dev/log).472hub # [ 2.015695] systemd[1]: Listening on Journal Sockets.473hub # [ 2.017428] systemd[1]: Listening on udev Control Socket.474hub # [ 2.019251] systemd[1]: Listening on udev Kernel Socket.475hub # [ 2.020943] systemd[1]: Reached target Socket Units.476hub # [ 2.023642] systemd[1]: Starting Create List of Static Device Nodes...477hub # [ 2.029642] systemd[1]: Starting Load Kernel Module 9pnet_virtio...478hub # [ 2.041917] systemd[1]: Starting Load Kernel Module configfs...479hub # [ 2.054308] systemd[1]: Starting Journal Service...480hub # [ 2.072185] systemd[1]: Starting Load Kernel Modules...481hub # [ 2.079214] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os482hub # [ 2.094983] netfs: FS-Cache loaded483hub # [ 2.100876] 9pnet: Installing 9P2000 support484hub # [ 2.124318] systemd[1]: Starting Coldplug All udev Devices...485hub # [ 2.132952] systemd-journald[67]: Collecting audit messages is disabled.486hub # [ 2.144205] systemd[1]: Finished Create List of Static Device Nodes.487hub # [ 2.149528] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.488hub # [ 2.154867] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.489hub # [ 2.163182] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev490hub # [ 2.166594] systemd[1]: Finished Load Kernel Module 9pnet_virtio.491hub # [ 2.173630] systemd[1]: modprobe@configfs.service: Deactivated successfully.492hub # [ 2.185740] systemd[1]: Finished Load Kernel Module configfs.493hub # [ 2.194832] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config494hub # [ 2.210325] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...495hub # [ 2.230604] systemd[1]: Finished Load Kernel Modules.496hub # [ 2.243320] systemd[1]: Starting Apply Kernel Variables...497hub # [ 2.259769] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.498hub # [ 2.274470] systemd[1]: Starting Create Static Device Nodes in /dev...499hub # [ 2.292731] systemd[1]: Finished Apply Kernel Variables.500hub # [ 2.316258] systemd[1]: Finished Create Static Device Nodes in /dev.501hub # [ 2.321467] systemd[1]: Reached target Preparation for Local File Systems.502hub # [ 2.328207] systemd[1]: Reached target Local File Systems.503hub # [ 2.337500] systemd[1]: Starting Rule-based Manager for Device Events and Files...504hub # [ 2.097621] systemd-modules-load[68]: Inserted module 'dm_mod'505hub # [ 2.102767] systemd-modules-load[68]: Inserted module 'virtio_balloon'506hub # [ 2.104623] systemd-modules-load[68]: Inserted module 'virtio_gpu'507hub # [ 2.352399] systemd[1]: Started Journal Service.508hub # [ 2.139723] systemd[1]: Starting Create System Files and Directories...509hub # [ 2.169721] systemd[1]: Finished Create System Files and Directories.510hub # [ 2.174322] systemd-udevd[76]: Using default interface naming scheme 'v261'.511hub # [ 2.209108] systemd[1]: Started Rule-based Manager for Device Events and Files.512hub # [ 2.265113] systemd[1]: Finished Coldplug All udev Devices.513hub # [ 2.266673] systemd[1]: Reached target System Initialization.514hub # [ 2.269244] systemd[1]: Reached target Basic System.515worker # Disk image does not exist, creating the virtualisation disk image...516worker: QEMU running (pid 48)517worker # Formatting '/build/vm-state-worker/tmp.XqhGe44yJU', fmt=raw size=1073741824518worker # mke2fs 1.47.4 (6-Mar-2025)519worker # Discarding device blocks: 0/262144 done520worker # Creating filesystem with 262144 4k blocks and 65536 inodes521(finished: start all VMs, in 3.52 seconds)522worker # Filesystem UUID: dd05f3a4-72a1-4c7a-a155-2f30710bfbe6523worker # Superblock backups stored on blocks:524worker # 32768, 98304, 163840, 229376525worker # 526worker # Allocating group tables: 0/8 done527worker # Writing inode tables: 0/8 done528worker # Creating journal (8192 blocks): done529worker # Writing superblocks and filesystem accounting information: 0/8 done530worker # 531worker # Virtualisation disk image created.532worker # Creating Nix store image...533worker # Created Nix store image.534hub: waiting for unit headscale535hub: waiting for the VM to finish booting536worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)537worker # 538worker # 539worker # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1900+7EF31900 CA00540worker # Press Ctrl-B to configure iPXE (PCI 00:03.0)...541worker # 542worker # 543worker # 544worker # 545worker # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1900 7EF31900 CB00546worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)...547worker # 548worker # 549hub # [ 2.803518] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12550hub # [ 2.829731] uhci_hcd 0000:00:01.2: UHCI Host Controller551hub # [ 2.834901] serio: i8042 KBD port at 0x60,0x64 irq 1552hub # [ 2.852844] virtio_blk virtio5: 1/0/0 default/read/poll queues553hub # [ 2.858112] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1554hub # [ 2.861451] serio: i8042 AUX port at 0x60,0x64 irq 12555hub # [ 2.876813] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)556worker # Booting from ROM...557hub # [ 2.883560] uhci_hcd 0000:00:01.2: detected 2 ports558hub # [ 2.886145] SCSI subsystem initialized559hub # [ 2.889653] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100560hub # [ 2.905712] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18561hub # [ 2.923170] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1562hub # [ 2.941331] usb usb1: Product: UHCI Host Controller563hub # [ 2.713372] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.564hub # [ 2.718396] systemd[1]: Starting Virtual Console Setup...565hub # [ 2.962798] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0566hub # [ 2.729336] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.567hub # [ 2.971779] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd568hub # [ 2.973277] usb usb1: SerialNumber: 0000:00:01.2569hub # [ 2.740252] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.570hub # [ 2.770320] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.571hub # [ 2.776983] systemd[1]: Finished Virtual Console Setup.572hub # [ 3.021912] hub 1-0:1.0: USB hub found573hub # [ 3.029647] hub 1-0:1.0: 2 ports detected574hub # [ 2.813082] systemd[1]: Found device /dev/disk/by-label/nixos.575hub # [ 2.814792] systemd[1]: Reached target Initrd Root Device.576hub # [ 2.817344] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...577hub # [ 3.080599] scsi host0: ata_piix578hub # [ 3.086538] scsi host1: ata_piix579hub # [ 3.090276] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0580hub # [ 3.093793] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0581hub # [ 2.858439] systemd-fsck[117]: nixos: clean, 12/65536 files, 13019/262144 blocks582hub # [ 2.864919] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.583hub # [ 2.901118] systemd[1]: Mounting /sysroot...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.251813] ata2: found unknown device (class 0)586worker # [ 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/2pmkwdggp8i4csdl5n05frjvx29a1yq4-nixos-system-worker-test/init regInfo=/nix/store/8jh89f10w31wf8fa8hmnry8fn1c50n07-closure-info/registration console=ttyS0,115200n8 console=tty0587worker # [ 0.000000] BIOS-provided physical RAM map:588worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable589worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved590worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved591hub # [ 3.257658] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100592worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable593worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved594hub # [ 3.261466] usb 1-1: new full-speed USB device number 2 using uhci_hcd595worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved596worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved597worker # [ 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: KVM604hub # [ 3.271643] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5605worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000606worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00607worker # [ 0.000000] kvm-clock: using sched offset of 547388424 cycles608worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns609worker # [ 0.000005] tsc: Detected 2400.018 MHz processor610worker # [ 0.000814] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000611worker # [ 0.000851] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs612worker # [ 0.000853] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT613worker # [ 0.002755] found SMP MP-table at [mem 0x000f5470-0x000f547f]614worker # [ 0.002766] Using GB pages for direct mapping615worker # [ 0.002899] RAMDISK: [mem 0x7e2fa000-0x7ffcffff]616worker # [ 0.002906] ACPI: Early table checksum verification disabled617worker # [ 0.002909] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )618worker # [ 0.002912] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)619worker # [ 0.002916] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)620worker # [ 0.002923] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)621worker # [ 0.002924] ACPI: FACS 0x000000007FFE0000 000040622worker # [ 0.002926] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)623worker # [ 0.002928] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)624worker # [ 0.002929] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)625worker # [ 0.002931] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]626worker # [ 0.002932] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]627worker # [ 0.002932] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]628worker # [ 0.002933] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]629worker # [ 0.002933] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]630worker # [ 0.002934] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]631worker # [ 0.003412] No NUMA configuration found632worker # [ 0.003414] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]633worker # [ 0.003417] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]634worker # [ 0.005764] Zone ranges:635worker # [ 0.005765] DMA [mem 0x0000000000001000-0x0000000000ffffff]636worker # [ 0.005767] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff]637worker # [ 0.005768] Normal empty638worker # [ 0.005769] Device empty639worker # [ 0.005769] Movable zone start for each node640worker # [ 0.005770] Early memory node ranges641worker # [ 0.005771] node 0: [mem 0x0000000000001000-0x000000000009efff]642worker # [ 0.005772] node 0: [mem 0x0000000000100000-0x000000007ffd7fff]643worker # [ 0.005773] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]644worker # [ 0.005792] On node 0, zone DMA: 1 pages in unavailable ranges645worker # [ 0.006066] On node 0, zone DMA: 97 pages in unavailable ranges646worker # [ 0.043262] On node 0, zone DMA32: 40 pages in unavailable ranges647worker # [ 0.044243] ACPI: PM-Timer IO Port: 0x608648worker # [ 0.044259] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])649worker # [ 0.044292] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23650worker # [ 0.044295] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)651worker # [ 0.044297] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)652worker # [ 0.044298] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)653worker # [ 0.044299] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)654worker # [ 0.044300] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)655worker # [ 0.044302] ACPI: Using ACPI (MADT) for SMP configuration information656worker # [ 0.044303] ACPI: HPET id: 0x8086a201 base: 0xfed00000657worker # [ 0.044307] TSC deadline timer available658worker # [ 0.044312] CPU topo: Max. logical packages: 1659worker # [ 0.044313] CPU topo: Max. logical dies: 1660hub # [ 3.353403] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray661worker # [ 0.044313] CPU topo: Max. dies per package: 1662worker # [ 0.044316] CPU topo: Max. threads per core: 1663worker # [ 0.044317] CPU topo: Num. cores per package: 1664worker # [ 0.044317] CPU topo: Num. threads per package: 1665worker # [ 0.044318] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs666worker # [ 0.044337] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()667worker # [ 0.044373] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]668worker # [ 0.044374] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]669worker # [ 0.044376] [mem 0x80000000-0xfeffbfff] available for PCI devices670worker # [ 0.044377] Booting paravirtualized kernel on KVM671worker # [ 0.044380] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns672worker # [ 0.048820] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1673worker # [ 0.051330] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152674hub # [ 3.373529] cdrom: Uniform CD-ROM driver Revision: 3.20675worker # [ 0.051376] kvm-guest: PV spinlocks disabled, single CPU676worker # [ 0.051377] 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/2pmkwdggp8i4csdl5n05frjvx29a1yq4-nixos-system-worker-test/init regInfo=/nix/store/8jh89f10w31wf8fa8hmnry8fn1c50n07-closure-info/registration console=ttyS0,115200n8 console=tty0677worker # [ 0.051468] Unknown kernel command line parameters "regInfo=/nix/store/8jh89f10w31wf8fa8hmnry8fn1c50n07-closure-info/registration", will be passed to user space.678worker # [ 0.051480] random: crng init done679worker # [ 0.051481] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes680worker # [ 0.053721] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)681worker # [ 0.053743] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)682worker # [ 0.053780] Fallback order for Node 0: 0683worker # [ 0.053782] Built 1 zonelists, mobility grouping on. Total pages: 524150684worker # [ 0.053783] Policy zone: DMA32685hub # [ 3.392983] EXT4-fs (vda): mounted filesystem 58b665c3-e498-4264-b597-c08ba8d7ce3a r/w with ordered data mode. Quota mode: none.686worker # [ 0.056381] mem auto-init: stack:all(zero), heap alloc:on, heap free:off687worker # [ 0.060110] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1688worker # [ 0.065362] allocated 4194304 bytes of page_ext689hub # [ 3.159770] systemd[1]: Mounted /sysroot.690worker # [ 0.075208] ftrace: allocating 48598 entries in 192 pages691worker # [ 0.075210] ftrace: allocated 192 pages with 2 groups692hub # [ 3.161912] systemd[1]: Reached target Initrd Root File System.693worker # [ 0.076077] Dynamic Preempt: lazy694worker # [ 0.076243] rcu: Preemptible hierarchical RCU implementation.695worker # [ 0.076244] rcu: RCU event tracing is enabled.696worker # [ 0.076245] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.697worker # [ 0.076246] Trampoline variant of Tasks RCU enabled.698worker # [ 0.076247] Rude variant of Tasks RCU enabled.699hub # [ 3.169109] systemd[1]: Mounting /sysroot/nix/.ro-store...700worker # [ 0.076247] Tracing variant of Tasks RCU enabled.701worker # [ 0.076248] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.702worker # [ 0.076249] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1703hub # [ 3.174109] systemd[1]: Mounting /sysroot/nix/.rw-store...704worker # [ 0.076306] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.705worker # [ 0.076308] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.706worker # [ 0.076309] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.707hub # [ 3.180211] systemd[1]: Mounting /sysroot/run...708worker # [ 0.080660] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16709worker # [ 0.080943] rcu: srcu_init: Setting srcu_struct sizes based on contention.710worker # [ 0.081052] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)711worker # [ 0.088336] Console: colour VGA+ 80x25712worker # [ 0.088341] printk: legacy console [tty0] enabled713worker # [ 0.128958] printk: legacy console [ttyS0] enabled714worker # [ 0.312885] ACPI: Core revision 20250807715worker # [ 0.314434] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns716worker # [ 0.317293] APIC: Switch to symmetric I/O mode setup717hub # [ 3.432488] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00718worker # [ 0.319083] x2apic enabled719hub # [ 3.434633] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10720worker # [ 0.320368] APIC: Switched APIC routing to: physical x2apic721hub # [ 3.197473] systemd[1]: Mounting /sysroot/tmp/shared...722worker # [ 0.323206] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1723worker # [ 0.325066] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns724hub # [ 3.442095] usb 1-1: Product: QEMU USB Tablet725hub # [ 3.444624] usb 1-1: Manufacturer: QEMU726worker # [ 0.328122] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018)727worker # [ 0.330269] x86/cpu: User Mode Instruction Prevention (UMIP) activated728hub # [ 3.447463] usb 1-1: SerialNumber: 28754-0000:00:01.2-1729worker # [ 0.331277] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127730worker # [ 0.332120] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0731hub # [ 3.212280] systemd[1]: Mounting /sysroot/tmp/xchg...732worker # [ 0.333124] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto733worker # [ 0.334121] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl734worker # [ 0.336120] Transient Scheduler Attacks: Mitigation: Clear CPU buffers735worker # [ 0.337120] Spectre V2 : Mitigation: Enhanced / Automatic IBRS736worker # [ 0.338120] Speculative Return Stack Overflow: Mitigation: Safe RET737worker # [ 0.340120] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization738worker # [ 0.342126] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier739worker # [ 0.343121] active return thunk: srso_alias_return_thunk740hub # [ 3.230251] systemd[1]: Starting Mountpoints Configured in the Real Root...741worker # [ 0.345149] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'742worker # [ 0.346120] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'743worker # [ 0.348120] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'744worker # [ 0.350120] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'745worker # [ 0.351120] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'746worker # [ 0.352120] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'747worker # [ 0.353120] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'748worker # [ 0.354120] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'749worker # [ 0.355120] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'750hub # [ 3.493173] hid: raw HID events driver (C) Jiri Kosina751worker # [ 0.356120] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256752worker # [ 0.357120] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64753worker # [ 0.358120] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512754worker # [ 0.360120] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024755worker # [ 0.362121] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8756worker # [ 0.363120] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16757worker # [ 0.364120] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24758worker # [ 0.365120] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.759hub # [ 3.509672] 9p: Installing v9fs 9p2000 file system support760hub # [ 3.279991] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload.761hub # [ 3.534157] usbcore: registered new interface driver usbhid762hub # [ 3.540212] usbhid: USB HID core driver763worker # [ 0.400127] Freeing SMP alternatives memory: 44K764worker # [ 0.401122] pid_max: default: 32768 minimum: 301765worker # [ 0.402235] LSM: initializing lsm=capability,landlock,yama,bpf,ima766worker # [ 0.404219] landlock: Up and running.767worker # [ 0.405973] Yama: becoming mindful.768worker # [ 0.407332] LSM support for eBPF active769worker # [ 0.408244] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)770hub # [ 3.311982] systemd[1]: Mounted /sysroot/nix/.ro-store.771worker # [ 0.410174] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)772hub # [ 3.316101] systemd[1]: Mounted /sysroot/nix/.rw-store.773hub # [ 3.317602] systemd[1]: Mounted /sysroot/run.774worker # [ 0.413241] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)775hub # [ 3.319275] systemd[1]: Mounted /sysroot/tmp/shared.776worker # [ 0.414712] Performance Events: Fam17h+ core perfctr, AMD PMU driver.777hub # [ 3.322230] systemd[1]: Mounted /sysroot/tmp/xchg.778worker # [ 0.415130] ... version: 2779worker # [ 0.416121] ... bit width: 48780worker # [ 0.417121] ... generic counters: 6781worker # [ 0.418121] ... generic bitmap: 000000000000003f782worker # [ 0.419121] ... fixed-purpose counters: 0783worker # [ 0.420121] ... fixed-purpose bitmap: 0000000000000000784worker # [ 0.421121] ... value mask: 0000ffffffffffff785worker # [ 0.422121] ... max period: 00007fffffffffff786hub # [ 3.333107] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)...787worker # [ 0.423122] ... global_ctrl mask: 000000000000003f788hub # [ 3.335815] systemd[1]: Reloading...789worker # [ 0.424224] signal: max sigframe size: 3376790worker # [ 0.425238] rcu: Hierarchical SRCU implementation.791worker # [ 0.426126] rcu: Max phase no-delay instances is 400.792hub # [ 3.577448] 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/input2793worker # [ 0.431791] smp: Bringing up secondary CPUs ...794worker # [ 0.432139] smp: Brought up 1 node, 1 CPU795hub # [ 3.585779] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0796worker # [ 0.433124] smpboot: Total of 1 processors activated (4800.03 BogoMIPS)797worker # [ 0.434354] Memory: 1969216K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved)798worker # [ 0.435427] devtmpfs: initialized799worker # [ 0.437189] x86/mm: Memory block size: 128MB800worker # [ 0.439294] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns801worker # [ 0.440151] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)802worker # [ 0.441151] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).803worker # [ 0.442214] pinctrl core: initialized pinctrl subsystem804worker # [ 0.443471] PM: RTC time: 09:23:58, date: 2026-07-13805worker # [ 0.447025] NET: Registered PF_NETLINK/PF_ROUTE protocol family806worker # [ 0.448649] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations807worker # [ 0.449153] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations808worker # [ 0.450410] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations809worker # [ 0.451134] audit: initializing netlink subsys (disabled)810worker # [ 0.452377] thermal_sys: Registered thermal governor 'fair_share'811worker # [ 0.452379] thermal_sys: Registered thermal governor 'bang_bang'812worker # [ 0.453125] audit: type=2000 audit(1783934638.533:1): state=initialized audit_enabled=0 res=1813worker # [ 0.455125] thermal_sys: Registered thermal governor 'step_wise'814worker # [ 0.455126] thermal_sys: Registered thermal governor 'user_space'815worker # [ 0.456122] thermal_sys: Registered thermal governor 'power_allocator'816worker # [ 0.457143] cpuidle: using governor menu817worker # [ 0.460291] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5818worker # [ 0.461428] PCI: Using configuration type 1 for base access819worker # [ 0.462122] PCI: Using configuration type 1 for extended access820worker # [ 0.463372] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.821worker # [ 0.469225] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages822worker # [ 0.470122] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page823worker # [ 0.475121] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages824worker # [ 0.476122] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page825worker # [ 0.483966] ACPI: Added _OSI(Module Device)826worker # [ 0.485122] ACPI: Added _OSI(Processor Device)827worker # [ 0.490866] ACPI: Added _OSI(Processor Aggregator Device)828hub # [ 3.442311] systemd[1]: Reloading finished in 109 ms.829worker # [ 0.495982] ACPI: 1 ACPI AML tables successfully acquired and loaded830worker # [ 0.502582] ACPI: Interpreter enabled831worker # [ 0.503139] ACPI: PM: (supports S0 S3 S4 S5)832worker # [ 0.504123] ACPI: Using IOAPIC for interrupt routing833hub # [ 3.452812] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace...834worker # [ 0.505143] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug835hub # [ 3.459111] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace...836worker # [ 0.508121] PCI: Using E820 reservations for host bridge windows837worker # [ 0.509273] ACPI: Enabled 2 GPEs in block 00 to 0F838hub # [ 3.463201] systemd[1]: Starting rw-sysroot-nix-store.service...839hub # [ 3.465817] systemd[1]: initrd-parse-etc.service: Deactivated successfully.840hub # [ 3.470126] systemd[1]: Finished Mountpoints Configured in the Real Root.841worker # [ 0.518254] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])842hub # [ 3.471918] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.843worker # [ 0.519128] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]844worker # [ 0.520498] acpiphp: Slot [3] registered845worker # [ 0.521165] acpiphp: Slot [4] registered846worker # [ 0.522184] acpiphp: Slot [5] registered847worker # [ 0.523215] acpiphp: Slot [6] registered848worker # [ 0.524161] acpiphp: Slot [7] registered849worker # [ 0.525163] acpiphp: Slot [8] registered850worker # [ 0.526177] acpiphp: Slot [9] registered851worker # [ 0.527163] acpiphp: Slot [10] registered852hub # [ 3.485165] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.853worker # [ 0.528167] acpiphp: Slot [11] registered854worker # [ 0.529176] acpiphp: Slot [12] registered855hub # [ 3.487757] systemd[1]: Finished rw-sysroot-nix-store.service.856worker # [ 0.530173] acpiphp: Slot [13] registered857worker # [ 0.531155] acpiphp: Slot [14] registered858worker # [ 0.532169] acpiphp: Slot [15] registered859worker # [ 0.533166] acpiphp: Slot [16] registered860worker # [ 0.534155] acpiphp: Slot [17] registered861worker # [ 0.535154] acpiphp: Slot [18] registered862worker # [ 0.536154] acpiphp: Slot [19] registered863worker # [ 0.537169] acpiphp: Slot [20] registered864worker # [ 0.538155] acpiphp: Slot [21] registered865worker # [ 0.539155] acpiphp: Slot [22] registered866worker # [ 0.540154] acpiphp: Slot [23] registered867worker # [ 0.541185] acpiphp: Slot [24] registered868worker # [ 0.542155] acpiphp: Slot [25] registered869worker # [ 0.543154] acpiphp: Slot [26] registered870worker # [ 0.544170] acpiphp: Slot [27] registered871worker # [ 0.545155] acpiphp: Slot [28] registered872worker # [ 0.546178] acpiphp: Slot [29] registered873worker # [ 0.547155] acpiphp: Slot [30] registered874worker # [ 0.548168] acpiphp: Slot [31] registered875worker # [ 0.549168] PCI host bridge to bus 0000:00876worker # [ 0.550129] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]877worker # [ 0.551122] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]878worker # [ 0.552122] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]879worker # [ 0.553122] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]880worker # [ 0.554123] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]881worker # [ 0.555124] pci_bus 0000:00: root bus resource [bus 00-ff]882worker # [ 0.556507] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint883worker # [ 0.558032] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint884worker # [ 0.560031] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint885worker # [ 0.562819] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f]886worker # [ 0.563211] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk887worker # [ 0.564122] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk888worker # [ 0.565123] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk889worker # [ 0.566122] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk890worker # [ 0.567631] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint891worker # [ 0.569186] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f]892worker # [ 0.571333] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint893worker # [ 0.572767] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI894worker # [ 0.574136] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB895worker # [ 0.575533] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint896worker # [ 0.578201] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]897worker # [ 0.579152] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]898worker # [ 0.580174] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]899worker # [ 0.581349] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]900worker # [ 0.583190] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint901worker # [ 0.586159] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]902worker # [ 0.587136] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]903worker # [ 0.588174] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]904worker # [ 0.589136] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]905worker # [ 0.592542] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint906worker # [ 0.595155] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f]907worker # [ 0.596136] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]908worker # [ 0.597174] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]909worker # [ 0.600160] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint910worker # [ 0.602815] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf]911worker # [ 0.604136] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]912worker # [ 0.605174] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]913worker # [ 0.608122] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint914worker # [ 0.610769] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df]915worker # [ 0.612139] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]916worker # [ 0.613174] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]917worker # [ 0.616114] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint918worker # [ 0.619158] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]919worker # [ 0.620136] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]920worker # [ 0.621174] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]921worker # [ 0.624108] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint922worker # [ 0.627195] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff]923worker # [ 0.628136] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]924worker # [ 0.629174] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]925worker # [ 0.632544] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint926worker # [ 0.634774] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff]927worker # [ 0.635137] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]928worker # [ 0.636173] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]929worker # [ 0.637137] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]930worker # [ 0.640115] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint931worker # [ 0.642159] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]932worker # [ 0.643174] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]933worker # [ 0.646100] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint934worker # [ 0.648851] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f]935worker # [ 0.650136] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]936worker # [ 0.651175] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]937worker # [ 0.654122] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint938worker # [ 0.656158] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f]939worker # [ 0.657137] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]940worker # [ 0.658174] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]941worker # [ 0.666398] ACPI: PCI: Interrupt link LNKA configured for IRQ 10942worker # [ 0.667337] ACPI: PCI: Interrupt link LNKB configured for IRQ 10943worker # [ 0.668310] ACPI: PCI: Interrupt link LNKC configured for IRQ 11944worker # [ 0.669314] ACPI: PCI: Interrupt link LNKD configured for IRQ 11945worker # [ 0.670226] ACPI: PCI: Interrupt link LNKS configured for IRQ 9946worker # [ 0.672251] iommu: Default domain type: Translated947worker # [ 0.673132] iommu: DMA domain TLB invalidation policy: lazy mode948worker # [ 0.674398] ACPI: bus type USB registered949worker # [ 0.675184] usbcore: registered new interface driver usbfs950worker # [ 0.676151] usbcore: registered new interface driver hub951worker # [ 0.677147] usbcore: registered new device driver usb952worker # [ 0.679035] NetLabel: Initializing953worker # [ 0.679951] NetLabel: domain hash size = 128954worker # [ 0.681121] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO955worker # [ 0.682190] NetLabel: unlabeled traffic allowed by default956worker # [ 0.683138] PCI: Using ACPI for IRQ routing957worker # [ 0.684794] pci 0000:00:02.0: vgaarb: setting as boot VGA device958worker # [ 0.685117] pci 0000:00:02.0: vgaarb: bridge control possible959worker # [ 0.685117] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none960worker # [ 0.685124] vgaarb: loaded961worker # [ 0.686264] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0962worker # [ 0.687121] hpet0: 3 comparators, 64-bit 100.000000 MHz counter963worker # [ 0.692203] clocksource: Switched to clocksource kvm-clock964worker # [ 0.696552] VFS: Disk quotas dquot_6.6.0965worker # [ 0.697809] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)966worker # [ 0.700071] pnp: PnP ACPI init967worker # [ 0.701801] pnp: PnP ACPI: found 6 devices968worker # [ 0.710079] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns969worker # [ 0.712682] clocksource: Switched to clocksource acpi_pm970worker # [ 0.714380] NET: Registered PF_INET protocol family971worker # [ 0.716281] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)972worker # [ 0.734576] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)973worker # [ 0.737268] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)974worker # [ 0.739587] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)975worker # [ 0.741963] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)976worker # [ 0.744219] TCP: Hash tables configured (established 16384 bind 16384)977worker # [ 0.746262] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)978worker # [ 0.748542] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)979worker # [ 0.750520] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)980worker # [ 0.752651] NET: Registered PF_UNIX/PF_LOCAL protocol family981worker # [ 0.754350] NET: Registered PF_XDP protocol family982worker # [ 0.755841] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]983worker # [ 0.757689] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]984worker # [ 0.759555] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]985worker # [ 0.761554] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]986worker # [ 0.763565] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]987worker # [ 0.765714] pci 0000:00:01.0: PIIX3: Enabling Passive Release988worker # [ 0.767476] pci 0000:00:00.0: Limiting direct PCI/PCI transfers989worker # [ 0.770784] ACPI: \_SB_.LNKD: Enabled at IRQ 11990worker # [ 0.774102] PCI: CLS 0 bytes, default 64991worker # [ 0.775627] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns992worker # [ 0.778971] Trying to unpack rootfs image as initramfs...993worker # [ 0.824679] Initialise system trusted keyrings994worker # [ 0.829256] workingset: timestamp_bits=40 max_order=19 bucket_order=0995hub # [ 3.904631] systemd[1]: Mounting /sysroot/nix/store...996worker # [ 0.854504] Key type asymmetric registered997worker # [ 0.855810] Asymmetric key parser 'x509' registered998worker # [ 0.859265] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)999worker # [ 0.865278] io scheduler mq-deadline registered1000worker # [ 0.870221] io scheduler kyber registered1001worker # [ 0.872094] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1002worker # [ 0.878482] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1003worker # [ 0.885387] Linux agpgart interface v0.1031004hub # [ 3.954899] systemd[1]: Mounted /sysroot/nix/store.1005worker # [ 0.886739] ACPI: bus type drm_connector registered1006hub # [ 3.957109] systemd[1]: Reached target Initrd File Systems.1007hub # [ 3.960109] systemd[1]: Starting Find NixOS closure...1008worker # [ 0.893363] usbcore: registered new interface driver usbserial_generic1009hub # [ 3.963562] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1010worker # [ 0.895270] usbserial: USB Serial support registered for generic1011worker # [ 0.900222] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.1012worker # [ 0.900222] Please enable it if your BIOS has the CPPC option.1013worker # [ 0.904111] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1014worker # [ 0.912373] drop_monitor: Initializing network drop monitor service1015worker # [ 0.914378] NET: Registered PF_INET6 protocol family1016hub # [ 3.986187] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1017worker # [ 0.919785] Segment Routing with IPv61018hub # [ 3.989736] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1019worker # [ 0.923237] In-situ OAM (IOAM) with IPv61020worker # [ 0.926507] IPI shorthand broadcast: enabled1021hub # [ 3.999133] systemd[1]: Finished Find NixOS closure.1022hub # [ 4.001500] systemd[1]: Reached target Initrd Default Target.1023hub # [ 4.004485] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1024worker # [ 0.935262] sched_clock: Marking stable (694028848, 241167466)->(1128133279, -192936965)1025worker # [ 0.943411] registered taskstats version 11026worker # [ 0.944940] Loading compiled-in X.509 certificates1027hub # [ 4.021401] systemd[1]: initrd-cleanup.service: Deactivated successfully.1028hub # [ 4.023853] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1029hub # [ 4.027766] systemd[1]: Stopped target Initrd Default Target.1030hub # [ 4.030281] systemd[1]: Stopped target Basic System.1031hub # [ 4.031694] systemd[1]: Stopped target Initrd Root Device.1032hub # [ 4.033207] systemd[1]: Stopped target Path Units.1033worker # [ 0.966213] Demotion targets for Node 0: null1034hub # [ 4.035253] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1035hub # [ 4.037215] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1036worker # [ 0.969255] Key type .fscrypt registered1037hub # [ 4.039396] systemd[1]: Stopped target Slice Units.1038hub # [ 4.041247] systemd[1]: Stopped target Socket Units.1039worker # [ 0.972211] Key type fscrypt-provisioning registered1040hub # [ 4.042892] systemd[1]: Stopped target System Initialization.1041worker # [ 0.973824] ima: No TPM chip found, activating TPM-bypass!1042hub # [ 4.044624] systemd[1]: Stopped target Swaps.1043hub # [ 4.046238] systemd[1]: Stopped target Timer Units.1044hub # [ 4.048241] systemd[1]: dbus.socket: Deactivated successfully.1045worker # [ 0.979226] ima: Allocated hash algorithm: sha11046worker # [ 0.980686] ima: No architecture policies found1047hub # [ 4.049804] systemd[1]: Closed D-Bus System Message Bus Socket.1048hub # [ 4.052209] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1049hub # [ 4.054141] systemd[1]: Stopped Find NixOS closure.1050worker # [ 0.985406] PM: Magic number: 2:758:3731051worker # [ 0.986696] vc vcsa1: hash matches1052hub # [ 4.056145] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1053worker # [ 0.990059] RAS: Correctable Errors collector initialized.1054hub # [ 4.060675] systemd[1]: Starting rw-sysroot-nix-store.service...1055hub # [ 4.062286] systemd[1]: systemd-sysctl.service: Deactivated successfully.1056hub # [ 4.064701] systemd[1]: Stopped Apply Kernel Variables.1057hub # [ 4.066209] systemd[1]: systemd-modules-load.service: Deactivated successfully.1058worker # [ 0.999999] clk: Disabling unused clocks1059hub # [ 4.070060] systemd[1]: Stopped Load Kernel Modules.1060hub # [ 4.071453] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1061hub # [ 4.073414] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1062worker # [ 1.005215] PM: genpd: Disabling unused power domains1063hub # [ 4.077188] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1064hub # [ 4.079064] systemd[1]: Stopped Create System Files and Directories.1065hub # [ 4.080705] systemd[1]: Stopped target Local File Systems.1066hub # [ 4.082994] systemd[1]: Stopped target Preparation for Local File Systems.1067hub # [ 4.086204] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1068hub # [ 4.089522] systemd[1]: Stopped Coldplug All udev Devices.1069hub # [ 4.092098] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1070hub # [ 4.095251] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1071hub # [ 4.097170] systemd[1]: Stopped Virtual Console Setup.1072hub # [ 4.103814] systemd[1]: systemd-udevd.service: Deactivated successfully.1073hub # [ 4.105720] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1074hub # [ 4.108713] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1075hub # [ 4.111274] systemd[1]: Closed udev Control Socket.1076hub # [ 4.114205] systemd[1]: Starting Cleanup udev Database...1077hub # [ 4.116253] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1078hub # [ 4.118224] systemd[1]: Stopped Create Static Device Nodes in /dev.1079hub # [ 4.120231] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1080hub # [ 4.123065] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1081hub # [ 4.124926] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1082hub # [ 4.126742] systemd[1]: Stopped Create List of Static Device Nodes.1083hub # [ 4.129229] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1084hub # [ 4.131181] systemd[1]: Finished rw-sysroot-nix-store.service.1085hub # [ 4.147930] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1086hub # [ 4.150836] systemd[1]: Finished Cleanup udev Database.1087hub # [ 4.153241] systemd[1]: Reached target Switch Root.1088hub # [ 4.156158] systemd[1]: Starting NixOS Activation...1089worker # [ 1.156309] Freeing initrd memory: 29528K1090worker # [ 1.160841] Freeing unused decrypted memory: 2028K1091worker # [ 1.164307] Freeing unused kernel image (initmem) memory: 3636K1092worker # [ 1.166245] Write protecting the kernel read-only data: 32768k1093worker # [ 1.168998] Freeing unused kernel image (text/rodata gap) memory: 1272K1094worker # [ 1.171490] Freeing unused kernel image (rodata/data gap) memory: 796K1095worker # [ 1.224673] x86/mm: Checked W+X mappings: passed, no W+X pages found.1096worker # [ 1.226636] Run /init as init process1097worker # [ 1.238404] systemd[1]: Inserted module 'autofs4'1098worker # [ 1.255580] fuse: init (API version 7.45)1099hub # [ 4.330478] initrd-nixos-activation-start[181]: booting system configuration /nix/store/sak6fic7mv49rnksnpn03rmr73vi5khs-nixos-system-hub-test1100worker # [ 1.263002] ACPI: \_SB_.LNKC: Enabled at IRQ 101101worker # [ 1.271702] ACPI: \_SB_.LNKA: Enabled at IRQ 101102worker # [ 1.276778] ACPI: \_SB_.LNKB: Enabled at IRQ 111103worker # [ 1.316226] systemd[1]: Successfully made /usr/ read-only.1104hub # [ 4.400316] initrd-nixos-activation-start[181]: running activation script...1105worker # [ 1.655482] 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)1106worker # [ 1.678353] systemd[1]: Detected virtualization kvm.1107worker # [ 1.682437] systemd[1]: Detected architecture x86-64.1108worker # [ 1.686657] systemd[1]: Running in initrd.1109worker # [ 1.691056] systemd[1]: Initializing machine ID from random generator.1110worker # [ 1.696567] systemd[1]: Hostname set to <worker>.1111hub # [ 4.835983] initrd-nixos-activation-start[204]: setting up /etc...1112worker # [ 1.914537] systemd[1]: bpf-restrict-fs: LSM BPF program attached1113worker # [ 1.975703] systemd[1]: Queued start job for default target Initrd Default Target.1114worker # [ 1.980887] systemd[1]: Created slice Slice /system/modprobe.1115worker # [ 1.983156] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1116worker # [ 1.985783] systemd[1]: Expecting device /dev/disk/by-label/nix-store...1117worker # [ 1.987998] systemd[1]: Expecting device /dev/disk/by-label/nixos...1118worker # [ 1.990104] systemd[1]: Reached target Path Units.1119worker # [ 1.991827] systemd[1]: Reached target Slice Units.1120worker # [ 1.993523] systemd[1]: Reached target Swaps.1121worker # [ 1.995074] systemd[1]: Reached target Timer Units.1122worker # [ 1.996959] systemd[1]: Listening on D-Bus System Message Bus Socket.1123worker # [ 1.999321] systemd[1]: Listening on Journal Socket (/dev/log).1124worker # [ 2.001470] systemd[1]: Listening on Journal Sockets.1125worker # [ 2.003409] systemd[1]: Listening on udev Control Socket.1126worker # [ 2.005348] systemd[1]: Listening on udev Kernel Socket.1127worker # [ 2.007135] systemd[1]: Reached target Socket Units.1128worker # [ 2.009955] systemd[1]: Starting Create List of Static Device Nodes...1129hub # [ 5.084751] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1130worker # [ 2.017293] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1131hub # [ 5.087164] systemd[1]: Finished NixOS Activation.1132hub # [ 5.089879] systemd[1]: Starting Switch Root...1133worker # [ 2.028455] systemd[1]: Starting Load Kernel Module configfs...1134hub # [ 5.105325] systemd[1]: Switching root.1135worker # [ 2.040411] systemd[1]: Starting Journal Service...1136worker # [ 2.060294] systemd[1]: Starting Load Kernel Modules...1137worker # [ 2.077106] netfs: FS-Cache loaded1138worker # [ 2.083084] 9pnet: Installing 9P2000 support1139worker # [ 2.093692] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1140worker # [ 2.105414] systemd[1]: Starting Coldplug All udev Devices...1141worker # [ 2.119076] systemd-journald[67]: Collecting audit messages is disabled.1142worker # [ 2.126002] systemd[1]: Finished Create List of Static Device Nodes.1143worker # [ 2.135095] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1144worker # [ 2.145658] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1145worker # [ 2.150856] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1146worker # [ 2.158711] systemd[1]: modprobe@configfs.service: Deactivated successfully.1147worker # [ 2.163234] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1148worker # [ 2.169862] systemd[1]: Finished Load Kernel Module configfs.1149hub # [ 5.477587] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1150worker # [ 2.180537] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1151worker # [ 2.199450] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1152worker # [ 2.218409] systemd[1]: Finished Load Kernel Modules.1153worker # [ 2.229291] systemd[1]: Starting Apply Kernel Variables...1154worker # [ 2.248398] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1155worker # [ 2.263574] systemd[1]: Starting Create Static Device Nodes in /dev...1156worker # [ 2.281855] systemd[1]: Finished Apply Kernel Variables.1157worker # [ 2.303089] systemd[1]: Finished Create Static Device Nodes in /dev.1158worker # [ 2.309620] systemd[1]: Reached target Preparation for Local File Systems.1159worker # [ 2.316306] systemd[1]: Reached target Local File Systems.1160hub # [ 5.632139] NET: Registered PF_VSOCK protocol family1161worker # [ 2.325489] systemd[1]: Starting Rule-based Manager for Device Events and Files...1162worker # [ 2.090637] systemd-modules-load[68]: Inserted module 'dm_mod'1163worker # [ 2.094689] systemd-modules-load[68]: Inserted module 'virtio_balloon'1164worker # [ 2.096570] systemd-modules-load[68]: Inserted module 'virtio_gpu'1165worker # [ 2.346265] systemd[1]: Started Journal Service.1166worker # [ 2.127364] systemd[1]: Starting Create System Files and Directories...1167worker # [ 2.156848] systemd[1]: Finished Create System Files and Directories.1168worker # [ 2.163312] systemd-udevd[74]: Using default interface naming scheme 'v261'.1169worker # [ 2.199193] systemd[1]: Started Rule-based Manager for Device Events and Files.1170worker # [ 2.249258] systemd[1]: Finished Coldplug All udev Devices.1171worker # [ 2.251813] systemd[1]: Reached target System Initialization.1172worker # [ 2.253405] systemd[1]: Reached target Basic System.1173hub # [ 6.018451] 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)1174hub # [ 6.034507] systemd[1]: Detected virtualization kvm.1175hub # [ 6.037725] systemd[1]: Detected architecture x86-64.1176hub # [ 6.040951] systemd[1]: Detected first boot.1177hub # [ 6.048323] systemd[1]: Initializing machine ID from random generator.1178worker # [ 2.808428] virtio_blk virtio4: 1/0/0 default/read/poll queues1179worker # [ 2.811876] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121180worker # [ 2.822934] uhci_hcd 0000:00:01.2: UHCI Host Controller1181worker # [ 2.845066] serio: i8042 KBD port at 0x60,0x64 irq 11182worker # [ 2.846792] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1183worker # [ 2.853691] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11184worker # [ 2.861244] serio: i8042 AUX port at 0x60,0x64 irq 121185worker # [ 2.864871] SCSI subsystem initialized1186worker # [ 2.871064] uhci_hcd 0000:00:01.2: detected 2 ports1187worker # [ 2.882588] virtio_blk virtio5: 1/0/0 default/read/poll queues1188worker # [ 2.884562] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1401189worker # [ 2.895271] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181190worker # [ 2.897861] virtio_blk virtio5: [vdb] 2081888 512-byte logical blocks (1.07 GB/1017 MiB)1191worker # [ 2.914208] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11192worker # [ 2.933636] usb usb1: Product: UHCI Host Controller1193worker # [ 2.697253] systemd[1]: Starting Virtual Console Setup...1194worker # [ 2.704054] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1195worker # [ 2.709658] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1196worker # [ 2.713335] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.1197worker # [ 2.964015] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01198worker # [ 2.971214] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd1199hub # [ 6.295456] systemd[1]: bpf-restrict-fs: LSM BPF program attached1200worker # [ 2.748366] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.1201worker # [ 2.995099] usb usb1: SerialNumber: 0000:00:01.21202worker # [ 2.756191] systemd[1]: Finished Virtual Console Setup.1203worker # [ 3.011722] hub 1-0:1.0: USB hub found1204worker # [ 3.023655] hub 1-0:1.0: 2 ports detected1205worker # [ 2.810580] systemd[1]: Found device /dev/disk/by-label/nixos.1206worker # [ 3.062857] scsi host0: ata_piix1207worker # [ 2.823859] systemd[1]: Found device /dev/disk/by-label/nix-store.1208worker # [ 2.825734] systemd[1]: Reached target Initrd Root Device.1209worker # [ 2.829912] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1210worker # [ 3.076849] scsi host1: ata_piix1211worker # [ 3.085274] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 01212worker # [ 3.089691] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 01213worker # [ 2.861773] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks1214worker # [ 2.868639] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1215hub # [ 6.431608] systemd[1]: Applying preset policy.1216worker # [ 2.884762] systemd[1]: Mounting /sysroot...1217worker # [ 3.251030] usb 1-1: new full-speed USB device number 2 using uhci_hcd1218worker # [ 3.255816] ata2: found unknown device (class 0)1219worker # [ 3.261923] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001220worker # [ 3.269725] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51221worker # [ 3.334928] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1222worker # [ 3.350645] cdrom: Uniform CD-ROM driver Revision: 3.201223worker # [ 3.377032] EXT4-fs (vda): mounted filesystem dd05f3a4-72a1-4c7a-a155-2f30710bfbe6 r/w with ordered data mode. Quota mode: none.1224worker # [ 3.141710] systemd[1]: Mounted /sysroot.1225worker # [ 3.143665] systemd[1]: Reached target Initrd Root File System.1226worker # [ 3.148636] systemd[1]: Starting Mountpoints Configured in the Real Root...1227worker # [ 3.164430] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload.1228worker # [ 3.172672] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)...1229worker # [ 3.175369] systemd[1]: Reloading...1230worker # [ 3.432320] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001231worker # [ 3.434750] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101232worker # [ 3.438868] usb 1-1: Product: QEMU USB Tablet1233worker # [ 3.440207] usb 1-1: Manufacturer: QEMU1234worker # [ 3.441128] usb 1-1: SerialNumber: 28754-0000:00:01.2-11235worker # [ 3.488059] hid: raw HID events driver (C) Jiri Kosina1236worker # [ 3.514321] usbcore: registered new interface driver usbhid1237worker # [ 3.515649] usbhid: USB HID core driver1238worker # [ 3.532474] 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/input21239worker # [ 3.545352] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input01240worker # [ 3.343825] systemd[1]: Reloading finished in 172 ms.1241worker # [ 3.353562] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace...1242worker # [ 3.360252] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace...1243worker # [ 3.366217] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1244worker # [ 3.370151] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1245worker # [ 3.372153] systemd[1]: Finished Mountpoints Configured in the Real Root.1246worker # [ 3.374097] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1247hub # [ 6.967563] systemd[1]: Populated /etc with preset unit settings.1248worker # [ 3.887268] systemd[1]: Mounting /sysroot/nix/.ro-store...1249worker # [ 3.897483] systemd[1]: Mounting /sysroot/nix/.rw-store...1250worker # [ 3.907459] systemd[1]: Mounting /sysroot/run...1251worker # [ 3.924326] systemd[1]: Mounting /sysroot/tmp/shared...1252worker # [ 3.939415] systemd[1]: Mounting /sysroot/tmp/xchg...1253worker # [ 3.969114] systemd[1]: Mounted /sysroot/nix/.rw-store.1254worker # [ 4.222631] erofs (device vdb): mounted with root inode @ nid 36.1255worker # [ 3.983510] systemd[1]: Mounted /sysroot/run.1256hub # [ 7.534255] systemd[1]: initrd-switch-root.service: Deactivated successfully.1257hub # [ 7.536705] systemd[1]: Stopped initrd-switch-root.service.1258hub # [ 7.540529] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1259hub # [ 7.543676] systemd[1]: Created slice Slice /system/getty.1260worker # [ 3.995708] systemd[1]: Starting rw-sysroot-nix-store.service...1261hub # [ 7.545731] systemd[1]: Created slice User and Session Slice.1262hub # [ 7.547306] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1263worker # [ 4.241241] 9p: Installing v9fs 9p2000 file system support1264hub # [ 7.549296] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1265hub # [ 7.551132] systemd[1]: Expecting device /dev/hvc0...1266hub # [ 7.552393] systemd[1]: Expecting device /dev/ttyS0...1267worker # [ 4.003285] systemd[1]: Mounted /sysroot/nix/.ro-store.1268hub # [ 7.553712] systemd[1]: Reached target Local Encrypted Volumes.1269hub # [ 7.555153] systemd[1]: Stopped target initrd-fs.target.1270hub # [ 7.556468] systemd[1]: Stopped target initrd-root-fs.target.1271hub # [ 7.557838] systemd[1]: Stopped target initrd-switch-root.target.1272hub # [ 7.559378] systemd[1]: Reached target Virtual Machines and Containers.1273hub # [ 7.560966] systemd[1]: Reached target Path Units.1274hub # [ 7.562263] systemd[1]: Reached target Remote File Systems.1275hub # [ 7.563647] systemd[1]: Reached target Slice Units.1276hub # [ 7.564919] systemd[1]: Reached target Swaps.1277worker # [ 4.016559] systemd[1]: Mounted /sysroot/tmp/shared.1278worker # [ 4.018511] systemd[1]: Mounted /sysroot/tmp/xchg.1279worker # [ 4.020310] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1280hub # [ 7.569580] systemd[1]: Listening on Query the User Interactively for a Password.1281worker # [ 4.022884] systemd[1]: Finished rw-sysroot-nix-store.service.1282hub # [ 7.575073] systemd[1]: Listening on Process Core Dump Socket.1283hub # [ 7.579421] systemd[1]: Listening on Credential Encryption/Decryption.1284hub # [ 7.583592] systemd[1]: Listening on Factory Reset Management.1285hub # [ 7.585202] systemd[1]: Listening on Hostname Service Socket.1286hub # [ 7.590578] systemd[1]: Starting Journal Log Access Socket...1287hub # [ 7.593015] systemd[1]: Listening on Journal Audit Socket.1288hub # [ 7.597172] systemd[1]: Listening on Console Output Muting Service Socket.1289hub # [ 7.599330] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1290hub # [ 7.601832] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1291hub # [ 7.604088] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1292hub # [ 7.618230] systemd[1]: Listening on Disk Repartitioning Service Socket.1293hub # [ 7.619966] systemd[1]: Listening on udev Control Socket.1294hub # [ 7.621536] systemd[1]: Listening on udev Varlink Socket.1295hub # [ 7.626664] systemd[1]: Mounting Huge Pages File System...1296hub # [ 7.631009] systemd[1]: Mounting POSIX Message Queue File System...1297hub # [ 7.638389] systemd[1]: Mounting Kernel Debug File System...1298hub # [ 7.646058] systemd[1]: Mounting Kernel Trace File System...1299hub # [ 7.654521] systemd[1]: Starting Create List of Static Device Nodes...1300hub # [ 7.657277] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1301hub # [ 7.669895] systemd[1]: Starting Load Kernel Module configfs...1302hub # [ 7.671665] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1303hub # [ 7.674757] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1304hub # [ 7.678089] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1305hub # [ 7.689145] systemd[1]: Mounting FUSE Control File System...1306hub # [ 7.691901] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671307hub # [ 7.728373] systemd[1]: Starting Journal Service...1308hub # [ 7.746105] systemd[1]: Starting Load Kernel Modules...1309hub # [ 7.762731] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1310hub # [ 7.775293] systemd[1]: Starting Remount Root and Kernel File Systems...1311hub # [ 7.784907] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1312hub # [ 7.794468] systemd[1]: Starting Coldplug All udev Devices...1313hub # [ 7.806240] systemd-journald[274]: Collecting audit messages is enabled.1314hub # [ 7.829746] systemd[1]: Listening on Journal Log Access Socket.1315hub # [ 7.840158] systemd[1]: Mounted Huge Pages File System.1316hub # [ 7.844126] loop: module loaded1317hub # [ 7.851272] systemd[1]: Mounted POSIX Message Queue File System.1318hub # [ 7.860216] systemd[1]: Mounted Kernel Debug File System.1319hub # [ 7.868383] systemd[1]: Mounted Kernel Trace File System.1320hub # [ 7.880684] systemd[1]: Finished Create List of Static Device Nodes.1321hub # [ 7.649510] systemd[1]: Queued start job for default target Multi-User System.[ 7.890542] EXT4-fs (vda): re-mounted 58b665c3-e498-4264-b597-c08ba8d7ce3a.1322hub # 1323hub # [ 7.893402] systemd[1]: Started Journal Service.1324hub # [ 7.655792] systemd[1]: systemd-journald.service: Deactivated successfully.1325hub # [ 7.662556] systemd-modules-load[275]: Inserted module 'loop'1326hub # [ 7.668521] systemd-modules-load[275]: Inserted module 'tls'1327hub # [ 7.672572] systemd[1]: modprobe@configfs.service: Deactivated successfully.1328hub # [ 7.679426] systemd[1]: Finished Load Kernel Module configfs.1329hub # [ 7.682590] systemd[1]: Mounted FUSE Control File System.1330hub # [ 7.686332] systemd[1]: Finished Load Kernel Modules.1331hub # [ 7.694139] systemd[1]: Finished Remount Root and Kernel File Systems.1332hub # [ 7.714124] systemd[1]: Listening on Disk Image Download Service Socket.1333hub # [ 7.718594] systemd-oomd[277]: No swap; memory pressure usage will be degraded1334hub # [ 7.723153] systemd[1]: Mounting Kernel Configuration File System...1335hub # [ 7.730920] systemd[1]: Starting Firewall...1336hub # [ 7.745600] systemd[1]: Starting Flush Journal to Persistent Storage...1337hub # [ 7.748553] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1338hub # [ 7.760207] systemd[1]: Starting Load/Save OS Random Seed...1339hub # [ 7.776326] systemd[1]: Starting Apply Kernel Variables...1340hub # [ 7.796310] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1341hub # [ 7.798281] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1342hub # [ 7.800595] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1343hub # [ 8.062140] systemd-journald[274]: Received client request to flush runtime journal.1344hub # [ 8.047802] systemd[1]: Finished Load/Save OS Random Seed.1345hub # [ 8.053254] systemd[1]: Reached target First Boot Complete.1346hub # [ 8.058443] systemd[1]: Mounted Kernel Configuration File System.1347hub # [ 8.063660] systemd[1]: Finished Apply Kernel Variables.1348hub # [ 8.066757] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1349hub # [ 8.070230] systemd[1]: Starting Create Static Device Nodes in /dev...1350hub # [ 8.072989] systemd[1]: Finished Flush Journal to Persistent Storage.1351hub # [ 8.104788] systemd[1]: Finished Create Static Device Nodes in /dev.1352hub # [ 8.109119] systemd[1]: Reached target Preparation for Local File Systems.1353hub # [ 8.114259] systemd[1]: Starting Rule-based Manager for Device Events and Files...1354hub # [ 8.179584] systemd[1]: Finished Coldplug All udev Devices.1355worker # [ 4.886878] systemd[1]: Mounting /sysroot/nix/store...1356hub # [ 8.214205] systemd-udevd[319]: Using default interface naming scheme 'v261'.1357worker # [ 4.939628] systemd[1]: Mounted /sysroot/nix/store.1358worker # [ 4.943429] systemd[1]: Reached target Initrd File Systems.1359worker # [ 4.949331] systemd[1]: Starting Find NixOS closure...1360worker # [ 4.958178] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1361worker # [ 4.981307] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1362worker # [ 4.986112] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1363hub # [ 8.300799] systemd[1]: Mounting /run/wrappers...1364worker # [ 4.994897] systemd[1]: Finished Find NixOS closure.1365worker # [ 4.997258] systemd[1]: Reached target Initrd Default Target.1366worker # [ 5.000194] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1367worker # [ 5.016371] systemd[1]: Stopped target Initrd Default Target.1368worker # [ 5.018242] systemd[1]: Stopped target Basic System.1369worker # [ 5.020162] systemd[1]: Stopped target Initrd Root Device.1370worker # [ 5.022231] systemd[1]: Stopped target Path Units.1371worker # [ 5.024124] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1372worker # [ 5.027212] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1373worker # [ 5.029484] systemd[1]: Stopped target Slice Units.1374worker # [ 5.031421] systemd[1]: Stopped target Socket Units.1375hub # [ 8.342091] systemd[1]: Mounted /run/wrappers.1376worker # [ 5.034185] systemd[1]: Stopped target System Initialization.1377hub # [ 8.344684] systemd[1]: Reached target Local File Systems.1378worker # [ 5.035830] systemd[1]: Stopped target Swaps.1379worker # [ 5.037308] systemd[1]: Stopped target Timer Units.1380hub # [ 8.349106] systemd[1]: Listening on Boot Loader Control Service Socket.1381worker # [ 5.039200] systemd[1]: dbus.socket: Deactivated successfully.1382worker # [ 5.040878] systemd[1]: Closed D-Bus System Message Bus Socket.1383worker # [ 5.043236] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1384hub # [ 8.354368] systemd[1]: Starting register-nix-paths.service...1385worker # [ 5.046247] systemd[1]: Stopped Find NixOS closure.1386hub # [ 8.358898] systemd[1]: Starting Create SUID/SGID Wrappers...1387worker # [ 5.047691] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1388worker # [ 5.050568] systemd[1]: Starting rw-sysroot-nix-store.service...1389hub # [ 8.362126] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1390worker # [ 5.052664] systemd[1]: systemd-sysctl.service: Deactivated successfully.1391worker # [ 5.055213] systemd[1]: Stopped Apply Kernel Variables.1392worker # [ 5.056865] systemd[1]: systemd-modules-load.service: Deactivated successfully.1393hub # [ 8.368467] systemd[1]: Starting Save Transient machine-id to Disk...1394worker # [ 5.060186] systemd[1]: Stopped Load Kernel Modules.1395worker # [ 5.061712] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1396worker # [ 5.063869] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1397worker # [ 5.066066] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1398worker # [ 5.068474] systemd[1]: Stopped Create System Files and Directories.1399worker # [ 5.071298] systemd[1]: Stopped target Local File Systems.1400worker # [ 5.073530] systemd[1]: Stopped target Preparation for Local File Systems.1401worker # [ 5.076305] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1402worker # [ 5.079246] systemd[1]: Stopped Coldplug All udev Devices.1403worker # [ 5.081223] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1404hub # [ 8.392570] systemd[1]: Starting Create System Files and Directories...1405worker # [ 5.084262] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1406worker # [ 5.086639] systemd[1]: Stopped Virtual Console Setup.1407hub # [ 8.398943] systemd[1]: Started Rule-based Manager for Device Events and Files.1408worker # [ 5.099112] systemd[1]: initrd-cleanup.service: Deactivated successfully.1409worker # [ 5.101689] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1410worker # [ 5.110137] systemd[1]: systemd-udevd.service: Deactivated successfully.1411worker # [ 5.112811] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1412worker # [ 5.115520] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1413worker # [ 5.118338] systemd[1]: Finished rw-sysroot-nix-store.service.1414worker # [ 5.122120] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1415worker # [ 5.124202] systemd[1]: Closed udev Control Socket.1416worker # [ 5.126485] systemd[1]: Starting Cleanup udev Database...1417worker # [ 5.129236] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1418worker # [ 5.131397] systemd[1]: Stopped Create Static Device Nodes in /dev.1419worker # [ 5.133348] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1420worker # [ 5.136107] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1421worker # [ 5.138183] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1422worker # [ 5.140219] systemd[1]: Stopped Create List of Static Device Nodes.1423hub # [ 8.460291] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1424hub # [ 8.467176] systemd[1]: Finished Save Transient machine-id to Disk.1425worker # [ 5.157874] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1426worker # [ 5.160857] systemd[1]: Finished Cleanup udev Database.1427worker # [ 5.163446] systemd[1]: Reached target Switch Root.1428worker # [ 5.166124] systemd[1]: Starting NixOS Activation...1429worker # [ 5.221392] initrd-nixos-activation-start[183]: booting system configuration /nix/store/2pmkwdggp8i4csdl5n05frjvx29a1yq4-nixos-system-worker-test1430worker # [ 5.242618] initrd-nixos-activation-start[183]: running activation script...1431hub # [ 8.559430] systemd[1]: Finished Create System Files and Directories.1432hub # [ 8.573212] systemd[1]: Starting Rebuild Journal Catalog...1433hub # [ 8.584885] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1434hub # [ 8.670678] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1435worker # [ 5.382652] initrd-nixos-activation-start[206]: setting up /etc...1436hub # [ 8.727973] systemd[1]: Finished Rebuild Journal Catalog.1437hub # [ 8.739718] systemd[1]: Starting Update is Completed...1438worker # [ 5.455298] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1439worker # [ 5.457585] systemd[1]: Finished NixOS Activation.1440worker # [ 5.460809] systemd[1]: Starting Switch Root...1441worker # [ 5.475643] systemd[1]: Switching root.1442hub # [ 8.802699] systemd[1]: Finished Update is Completed.1443worker # [ 5.849926] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1444hub # [ 8.942253] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1445worker # [ 5.936745] NET: Registered PF_VSOCK protocol family1446hub # [ 9.111521] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1447hub # [ 9.115223] systemd[1]: Finished Create SUID/SGID Wrappers.1448hub # [ 9.170830] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1449hub # [ 9.242453] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1450hub # [ 9.262335] (udev-worker)[412]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1451hub # [ 9.273441] (udev-worker)[412]: Network interface NamePolicy= disabled on kernel command line.1452hub # [ 9.277928] (udev-worker)[397]: Network interface NamePolicy= disabled on kernel command line.1453worker # [ 6.293983] 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)1454worker # [ 6.310036] systemd[1]: Detected virtualization kvm.1455worker # [ 6.313239] systemd[1]: Detected architecture x86-64.1456worker # [ 6.316454] systemd[1]: Detected first boot.1457worker # [ 6.320246] systemd[1]: Initializing machine ID from random generator.1458hub # [ 9.426527] systemd[1]: Finished register-nix-paths.service.1459hub # [ 9.428273] systemd[1]: Reached target System Initialization.1460hub # [ 9.432755] systemd[1]: Started Discard unused filesystem blocks once a week.1461hub # [ 9.435201] systemd[1]: Started Daily Cleanup of Temporary Directories.1462hub # [ 9.438621] systemd[1]: Reached target Timer Units.1463hub # [ 9.441657] systemd[1]: Listening on D-Bus System Message Bus Socket.1464hub # [ 9.444486] systemd[1]: Listening on Nix Daemon Socket.1465hub # [ 9.447154] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1466hub # [ 9.449354] systemd[1]: Reached target Socket Units.1467hub # [ 9.451892] systemd[1]: Reached target Basic System.1468hub # [ 9.456233] systemd[1]: Started backdoor.service.1469hub # [ 9.462656] systemd[1]: Starting Import lastlog data into lastlog2 database...1470hub # [ 9.475851] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1471hub # [ 9.493696] systemd[1]: Starting Post-Boot Actions...1472hub # [ 9.514987] systemd[1]: Started Reset console on configuration changes.1473hub # [ 9.537129] systemd[1]: Starting resolvconf update...1474hub # [ 9.567404] systemd[1]: Finished Firewall.1475hub # connecting to host...1476hub # [ 9.614122] systemd[1]: Finished Post-Boot Actions.1477hub # [ 9.626904] systemd[1]: Started Name Service Cache Daemon (nsncd).1478hub # [ 9.631628] nsncd[506]: Jul 13 09:24:04.643 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1479worker # [ 6.563101] systemd[1]: bpf-restrict-fs: LSM BPF program attached1480hub # [ 9.637112] systemd[1]: Condition check resulted in Virtio network device being skipped.1481hub # [ 9.649422] systemd[1]: Reached target Host and Network Name Lookups.1482hub # [ 9.651143] systemd[1]: Reached target User and Group Name Lookups.1483hub: Guest shell says: b'Spawning backdoor root shell...\n'1484hub # [ 9.664704] systemd[1]: Starting D-Bus System Message Bus...1485hub: connected to guest root shell1486hub: (connecting took 7.33 seconds)1487hub: (finished: waiting for the VM to finish booting, in 7.33 seconds)1488hub # [ 9.687837] systemd[1]: Starting User Login Management...1489hub # [ 9.698383] systemd[1]: Finished Import lastlog data into lastlog2 database.1490worker # [ 6.677655] systemd[1]: Applying preset policy.1491hub # [ 9.860259] systemd[1]: Stopped target Host and Network Name Lookups.1492hub # [ 9.862071] systemd[1]: Stopping Host and Network Name Lookups...1493hub # [ 9.863662] systemd[1]: Stopped target User and Group Name Lookups.1494hub # [ 9.870186] systemd[1]: Stopping User and Group Name Lookups...1495hub # [ 9.874596] dbus-broker-launch[535]: Looking up NSS user entry for 'systemd-timesync'...1496hub # [ 9.877782] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1497hub # [ 9.881546] systemd[1]: nscd.service: Deactivated successfully.1498worker # [ 6.815589] systemd[1]: Populated /etc with preset unit settings.1499hub # [ 9.886237] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1500hub # [ 9.890465] dbus-broker-launch[535]: NSS returned no entry for 'systemd-timesync'1501hub # [ 9.893047] dbus-broker-launch[535]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1502hub # [ 9.924233] systemd-logind[538]: New seat seat0.1503hub # [ 9.934365] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1504hub # [ 9.937739] systemd[1]: Started User Login Management.1505hub # [ 9.942483] systemd[1]: Started D-Bus System Message Bus.1506hub # [ 10.196798] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31507hub # [ 10.231697] ACPI: button: Power Button [PWRF]1508hub # [ 9.997865] dbus-broker-launch[535]: Ready1509worker # [ 6.930303] systemd[1]: initrd-switch-root.service: Deactivated successfully.1510worker # [ 6.932630] systemd[1]: Stopped initrd-switch-root.service.1511worker # [ 6.936389] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1512worker # [ 6.939551] systemd[1]: Created slice Slice /system/getty.1513worker # [ 6.941640] systemd[1]: Created slice User and Session Slice.1514worker # [ 6.943248] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1515hub # [ 10.251788] mousedev: PS/2 mouse device common for all mice1516worker # [ 6.945325] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1517worker # [ 6.947109] systemd[1]: Expecting device /dev/hvc0...1518worker # [ 6.948423] systemd[1]: Expecting device /dev/ttyS0...1519worker # [ 6.949728] systemd[1]: Reached target Local Encrypted Volumes.1520worker # [ 6.951222] systemd[1]: Stopped target initrd-fs.target.1521worker # [ 6.952525] systemd[1]: Stopped target initrd-root-fs.target.1522hub # [ 10.022186] systemd[1]: Finished resolvconf update.1523worker # [ 6.953925] systemd[1]: Stopped target initrd-switch-root.target.1524worker # [ 6.955495] systemd[1]: Reached target Virtual Machines and Containers.1525worker # [ 6.957130] systemd[1]: Reached target Path Units.1526hub # [ 10.027105] systemd[1]: Started Name Service Cache Daemon (nsncd).1527worker # [ 6.958385] systemd[1]: Reached target Remote File Systems.1528worker # [ 6.959755] systemd[1]: Reached target Slice Units.1529worker # [ 6.961026] systemd[1]: Reached target Swaps.1530hub # [ 10.029386] nsncd[592]: Jul 13 09:24:05.049 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1531worker # [ 6.963031] systemd[1]: Listening on Query the User Interactively for a Password.1532worker # [ 6.965861] systemd[1]: Listening on Process Core Dump Socket.1533worker # [ 6.967892] systemd[1]: Listening on Credential Encryption/Decryption.1534worker # [ 6.970266] systemd[1]: Listening on Factory Reset Management.1535worker # [ 6.971850] systemd[1]: Listening on Hostname Service Socket.1536hub # [ 10.040961] systemd[1]: Reached target Preparation for Network.1537worker # [ 6.974899] systemd[1]: Starting Journal Log Access Socket...1538hub # [ 10.045077] systemd[1]: Reached target Host and Network Name Lookups.1539worker # [ 6.976958] systemd[1]: Listening on Journal Audit Socket.1540hub # [ 10.046710] systemd[1]: Reached target User and Group Name Lookups.1541worker # [ 6.980196] systemd[1]: Listening on Console Output Muting Service Socket.1542worker # [ 6.982037] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1543worker # [ 6.983930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1544hub # [ 10.054128] systemd[1]: Starting DHCP Client...1545worker # [ 6.986264] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1546worker # [ 6.989922] systemd[1]: Listening on Disk Repartitioning Service Socket.1547worker # [ 6.991719] systemd[1]: Listening on udev Control Socket.1548hub # [ 10.061631] systemd[1]: Starting linger-users.service...1549worker # [ 6.993272] systemd[1]: Listening on udev Varlink Socket.1550worker # [ 6.996596] systemd[1]: Mounting Huge Pages File System...1551worker # [ 7.002495] systemd[1]: Mounting POSIX Message Queue File System...1552hub # [ 10.075272] systemd[1]: Starting Address configuration of eth1...1553worker # [ 7.009693] systemd[1]: Mounting Kernel Debug File System...1554hub # [ 10.085081] systemd[1]: Starting Extra networking commands....1555worker # [ 7.020453] systemd[1]: Mounting Kernel Trace File System...1556worker # [ 7.035282] systemd[1]: Starting Create List of Static Device Nodes...1557hub # [ 10.104894] systemd[1]: Starting Tailscale node agent...1558worker # [ 7.043629] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1559worker # [ 7.061402] systemd[1]: Starting Load Kernel Module configfs...1560worker # [ 7.065261] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1561worker # [ 7.068535] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1562worker # [ 7.071185] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1563worker # [ 7.079205] systemd[1]: Mounting FUSE Control File System...1564worker # [ 7.084662] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671565worker # [ 7.095745] systemd[1]: Starting Journal Service...1566worker # [ 7.102870] systemd[1]: Starting Load Kernel Modules...1567hub # [ 10.411077] rtc_cmos 00:05: RTC can wake from S41568worker # [ 7.115538] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1569hub # [ 10.188594] systemd[1]: linger-users.service: Deactivated successfully.1570hub # [ 10.190459] systemd[1]: Finished linger-users.service.1571worker # [ 7.132290] systemd[1]: Starting Remount Root and Kernel File Systems...1572worker # [ 7.140846] systemd-journald[276]: Collecting audit messages is enabled.1573worker # [ 7.144356] loop: module loaded1574worker # [ 7.145596] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1575worker # [ 7.157293] systemd[1]: Starting Coldplug All udev Devices...1576worker # [ 7.186664] systemd[1]: Listening on Journal Log Access Socket.1577worker # [ 7.188196] EXT4-fs (vda): re-mounted dd05f3a4-72a1-4c7a-a155-2f30710bfbe6.1578worker # [ 7.197047] systemd[1]: Mounted Huge Pages File System.1579worker # [ 6.960400] systemd[1]: Queued start job for default target Multi-User System.1580worker # [ 6.964382] systemd[1]: Unnecessary job was removed for /dev/vdb.1581worker # [ 7.209522] systemd[1]: Started Journal Service.1582worker # [ 6.970309] systemd[1]: systemd-journald.service: Deactivated successfully.1583hub # [ 10.283280] network-addresses-eth1-start[613]: adding address 192.168.1.1/24... done1584worker # [ 6.974315] systemd-modules-load[277]: Inserted module 'loop'1585worker # [ 6.978559] systemd[1]: Mounted POSIX Message Queue File System.1586worker # [ 6.981544] systemd[1]: Mounted Kernel Debug File System.1587worker # [ 6.986544] systemd[1]: Mounted Kernel Trace File System.1588worker # [ 6.993362] systemd[1]: Finished Create List of Static Device Nodes.1589worker # [ 6.997605] systemd[1]: modprobe@configfs.service: Deactivated successfully.1590worker # [ 7.000315] systemd[1]: Finished Load Kernel Module configfs.1591hub # [ 10.310851] network-addresses-eth1-start[613]: adding address 2001:db8:1::1/64... done1592worker # [ 7.001902] systemd[1]: Mounted FUSE Control File System.1593hub # [ 10.555581] Floppy drive(s): fd0 is 2.88M AMI BIOS1594worker # [ 7.007136] systemd[1]: Finished Load Kernel Modules.1595worker # [ 7.012145] systemd[1]: Finished Remount Root and Kernel File Systems.1596worker # [ 7.032321] systemd-oomd[279]: No swap; memory pressure usage will be degraded1597worker # [ 7.035371] systemd[1]: Listening on Disk Image Download Service Socket.1598worker # [ 7.040227] systemd[1]: Mounting Kernel Configuration File System...1599hub # [ 10.351987] systemd[1]: Finished Address configuration of eth1.1600worker # [ 7.052107] systemd[1]: Starting Firewall...1601worker # [ 7.062102] systemd[1]: Starting Flush Journal to Persistent Storage...1602hub # [ 10.612097] parport_pc 00:03: reported by Plug and Play ACPI1603worker # [ 7.063809] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1604worker # [ 7.073101] systemd[1]: Starting Load/Save OS Random Seed...1605worker # [ 7.089107] systemd[1]: Starting Apply Kernel Variables...1606worker # [ 7.108955] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1607worker # [ 7.111218] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1608worker # [ 7.113866] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1609hub # [ 10.424693] dhcpcd[627]: dhcpcd-10.3.2 starting1610hub # [ 10.674766] FDC 0 is a S82078B1611hub # [ 10.439522] dhcpcd[677]: dev: loaded udev1612hub # [ 10.451436] systemd[1]: Finished Extra networking commands..1613hub # [ 10.458688] systemd[1]: Reached target Network.1614hub # [ 10.470410] systemd[1]: Starting Nginx Web Server...1615hub # [ 10.711168] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1616worker # [ 7.405927] systemd-journald[276]: Received client request to flush runtime journal.1617hub # [ 10.480189] systemd[1]: Starting Permit User Sessions...1618hub # [ 10.728528] 8021q: 802.1Q VLAN Support v1.81619hub # [ 10.734421] 8021q: adding VLAN 0 to HW filter on device eth11620hub # [ 10.736958] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1621hub # [ 10.558240] systemd[1]: Finished Permit User Sessions.1622hub # [ 10.700590] tailscaled[615]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1623worker # [ 7.392365] systemd[1]: Mounted Kernel Configuration File System.1624worker # [ 7.397669] systemd[1]: Finished Load/Save OS Random Seed.1625worker # [ 7.401462] systemd[1]: Reached target First Boot Complete.1626worker # [ 7.406506] systemd[1]: Finished Apply Kernel Variables.1627worker # [ 7.412175] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1628worker # [ 7.414092] systemd[1]: Starting Create Static Device Nodes in /dev...1629worker # [ 7.416346] systemd[1]: Finished Create Static Device Nodes in /dev.1630worker # [ 7.420235] systemd[1]: Reached target Preparation for Local File Systems.1631worker # [ 7.423176] systemd[1]: Starting Rule-based Manager for Device Events and Files...1632worker # [ 7.427314] systemd-udevd[320]: Using default interface naming scheme 'v261'.1633worker # [ 7.429391] systemd[1]: Finished Flush Journal to Persistent Storage.1634hub # [ 10.795788] tailscaled[615]: logtail started1635worker # [ 7.493363] systemd[1]: Started Rule-based Manager for Device Events and Files.1636hub # [ 10.800824] tailscaled[615]: 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"}1637hub # [ 10.808423] tailscaled[615]: LogID: 86b92cbc5a27063c523a7074b973c8b3780c6319a14022c67168268c00ca75981638hub # [ 10.813163] tailscaled[615]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1639hub # [ 10.822353] tailscaled[615]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1640hub # [ 10.825537] tailscaled[615]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1641hub # [ 10.830921] tailscaled[615]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:34671->[::1]:53: read: connection refused (in 31ms), trying bootstrap...1642hub # [ 10.844951] tailscaled[615]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ...1643hub # [ 10.855541] tailscaled[615]: 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 unreachable1644hub # [ 10.861610] tailscaled[615]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ...1645hub # [ 10.866148] tailscaled[615]: 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 unreachable1646hub # [ 10.872147] tailscaled[615]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...1647worker # [ 7.563316] systemd[1]: Finished Coldplug All udev Devices.1648hub # [ 10.874686] tailscaled[615]: 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 unreachable1649hub # [ 10.882544] tailscaled[615]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ...1650hub # [ 10.886515] tailscaled[615]: bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:0:d1::67d:8001]:443: connect: network is unreachable1651hub # [ 10.892622] tailscaled[615]: trying bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" ...1652hub # [ 10.895514] tailscaled[615]: bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.65:443: connect: network is unreachable1653hub # [ 10.901476] tailscaled[615]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ...1654hub # [ 10.904791] tailscaled[615]: bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b]:443: connect: network is unreachable1655hub # [ 10.910801] tailscaled[615]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ...1656hub # [ 10.819902] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01657hub # [ 10.916186] tailscaled[615]: 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 unreachable1658hub # [ 10.920620] tailscaled[615]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ...1659hub # [ 10.923313] tailscaled[615]: 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 unreachable1660hub # [ 10.928581] tailscaled[615]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ...1661hub # [ 10.932497] tailscaled[615]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable1662hub # [ 10.938153] tailscaled[615]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ...1663hub # [ 10.941375] tailscaled[615]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60]:443: connect: network is unreachable1664hub # [ 10.947565] tailscaled[615]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ...1665hub # [ 10.951432] tailscaled[615]: bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 206.189.16.32:443: connect: network is unreachable1666hub # [ 10.957605] tailscaled[615]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ...1667hub # [ 10.961214] tailscaled[615]: bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::873:4001]:443: connect: network is unreachable1668hub # [ 10.966313] tailscaled[615]: logtail: upload: log upload of 474 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/e018d7c85455efa6da268fbe86885f6c247efc4af7886299ac2de6b1dbf43978": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1669hub # [ 10.819976] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1670hub # [ 10.961354] rtc_cmos 00:05: registered as rtc01671worker # [ 7.697156] systemd[1]: Mounting /run/wrappers...1672hub # [ 11.012258] dhcpcd[677]: eth0: waiting for carrier1673hub # [ 11.016183] dhcpcd[677]: eth0: carrier acquired1674hub # [ 11.032398] nginx-pre-start[691]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok1675worker # [ 7.728117] systemd[1]: Mounted /run/wrappers.1676hub # [ 11.037467] nginx-pre-start[691]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful1677worker # [ 7.729537] systemd[1]: Reached target Local File Systems.1678hub # [ 11.041707] dhcpcd[677]: DUID 00:01:00:01:31:e7:6b:35:52:54:00:12:34:561679hub # [ 11.044724] dhcpcd[677]: eth0: IAID 00:12:34:561680worker # [ 7.734823] systemd[1]: Listening on Boot Loader Control Service Socket.1681hub # [ 11.046761] dhcpcd[677]: eth0: adding address fe80::5054:ff:fe12:34561682hub # [ 10.961509] rtc_cmos 00:05: setting system clock to 2026-07-13T09:24:05 UTC (1783934645)1683hub # [ 10.961697] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1684worker # [ 7.743112] systemd[1]: Starting register-nix-paths.service...1685worker # [ 7.755116] systemd[1]: Starting Create SUID/SGID Wrappers...1686worker # [ 7.756677] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1687worker # [ 7.769115] systemd[1]: Starting Save Transient machine-id to Disk...1688hub # [ 10.962419] systemd-journald[274]: Time jumped backwards, rotating.1689hub # [ 10.964867] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41690worker # [ 7.781263] systemd[1]: Starting Create System Files and Directories...1691worker # [ 7.801167] systemd[1]: Finished Firewall.1692hub # [ 10.987376] cfg80211: Loading compiled-in X.509 certificates for regulatory database1693hub # [ 11.029520] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1694hub # [ 11.142618] dhcpcd[677]: eth0: soliciting a DHCP lease1695hub # [ 11.029639] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1696hub # [ 11.031630] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21697worker # [ 7.862230] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1698hub # [ 11.177659] dhcpcd[677]: eth0: offered 10.0.2.15 from 10.0.2.21699hub # [ 11.181238] dhcpcd[677]: eth0: probing address 10.0.2.15/241700worker # [ 7.874968] systemd[1]: Finished Save Transient machine-id to Disk.1701hub # [ 11.031638] cfg80211: failed to load regulatory.db1702hub # [ 11.120649] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61703hub # [ 11.202549] systemd-logind[538]: Watching system buttons on /dev/input/event2 (Power Button)1704hub # [ 11.208486] systemd-logind[538]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1705hub # [ 11.121077] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51706hub # [ 11.153363] Console: switching to colour dummy device 80x251707worker # [ 7.905147] systemd[1]: Finished Create System Files and Directories.1708hub # [ 11.249658] 8021q: adding VLAN 0 to HW filter on device eth01709hub # [ 11.411901] NET: Registered PF_PACKET protocol family1710worker # [ 7.916444] systemd[1]: Starting Rebuild Journal Catalog...1711hub # [ 11.440757] ppdev: user-space parallel port driver1712hub # [ 11.472990] [drm] Found bochs VGA, ID 0xb0c5.1713hub # [ 11.472992] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1714hub # [ 11.237249] systemd[1]: Started Getty on tty1.1715worker # [ 7.928126] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1716hub # [ 11.240452] systemd[1]: Reached target Login Prompts.1717worker # [ 7.930459] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1718hub # [ 11.483911] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1719hub # [ 11.485287] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01720hub # [ 11.250838] systemd[1]: Started Nginx Web Server.1721hub # [ 11.270043] dbus-broker-launch[535]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1722worker # [ 8.006149] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1723hub # [ 11.317963] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1724hub # [ 11.325473] tailscaled[615]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1725hub # [ 11.327380] tailscaled[615]: dns: using "openresolv" mode1726hub # [ 11.332400] systemd[1]: Starting Virtual Console Setup...1727hub # [ 11.338510] tailscaled[615]: dns: using dns.openresolvManager1728worker # [ 8.051165] systemd[1]: Finished Rebuild Journal Catalog.1729worker # [ 8.065677] systemd[1]: Starting Update is Completed...1730worker # [ 8.115475] systemd[1]: Finished Update is Completed.1731hub # [ 11.580252] fbcon: bochs-drmdrmfb (fb0) is primary device1732hub # [ 11.661598] Console: switching to colour frame buffer device 160x501733hub # [ 11.681888] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1734worker # [ 8.200226] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1735worker # [ 8.224200] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1736worker # [ 8.230218] systemd[1]: Finished Create SUID/SGID Wrappers.1737hub # [ 11.783753] kvm_amd: TSC scaling supported1738hub # [ 11.784820] kvm_amd: Nested Virtualization enabled1739hub # [ 11.787254] kvm_amd: Nested Paging enabled1740hub # [ 11.788411] kvm_amd: LBR virtualization supported1741hub # [ 11.789942] kvm_amd: Virtual VMLOAD VMSAVE supported1742hub # [ 11.791478] kvm_amd: Virtual GIF supported1743hub # [ 11.792794] kvm_amd: Virtual NMI enabled1744worker # [ 8.288185] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1745worker # [ 8.293362] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line.1746hub # [ 11.877769] EDAC MC: Ver: 3.0.01747worker # [ 8.327972] (udev-worker)[402]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1748worker # [ 8.331693] (udev-worker)[402]: Network interface NamePolicy= disabled on kernel command line.1749worker # [ 8.387192] systemd[1]: Finished register-nix-paths.service.1750worker # [ 8.391827] systemd[1]: Reached target System Initialization.1751worker # [ 8.393423] systemd[1]: Started Discard unused filesystem blocks once a week.1752worker # [ 8.395334] systemd[1]: Started Daily Cleanup of Temporary Directories.1753worker # [ 8.398418] systemd[1]: Reached target Timer Units.1754worker # [ 8.400269] systemd[1]: Listening on D-Bus System Message Bus Socket.1755worker # [ 8.402233] systemd[1]: Listening on Nix Daemon Socket.1756worker # [ 8.405808] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1757worker # [ 8.407961] systemd[1]: Listening on tribuchet-sandboxd.socket.1758worker # [ 8.409630] systemd[1]: Reached target Socket Units.1759worker # [ 8.412273] systemd[1]: Reached target Basic System.1760worker # [ 8.414360] systemd[1]: Started backdoor.service.1761worker # [ 8.425212] systemd[1]: Starting Import lastlog data into lastlog2 database...1762hub # [ 11.736122] systemd-logind[538]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1763worker # [ 8.435800] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1764worker # [ 8.447122] systemd[1]: Starting Post-Boot Actions...1765worker # [ 8.462720] systemd[1]: Started Reset console on configuration changes.1766hub # [ 11.777943] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1767hub # [ 11.780981] systemd[1]: Stopped Virtual Console Setup.1768hub # [ 11.792505] tailscaled[615]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1769worker # [ 8.483341] systemd[1]: Starting resolvconf update...1770worker # connecting to host...1771hub # [ 11.796528] systemd[1]: Starting Virtual Console Setup...1772hub # [ 11.799892] systemd[1]: Started Tailscale node agent.1773hub # [ 12.066450] tun: Universal TUN/TAP device driver, 1.61774hub # [ 11.839407] (udev-worker)[742]: Network interface NamePolicy= disabled on kernel command line.1775worker # [ 8.541561] systemd[1]: Finished Post-Boot Actions.1776worker # [ 8.545903] systemd[1]: Started Name Service Cache Daemon (nsncd).1777worker # [ 8.547802] nsncd[503]: Jul 13 09:24:06.862 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1778worker # [ 8.570700] systemd[1]: Condition check resulted in Virtio network device being skipped.1779worker # [ 8.579158] systemd[1]: Finished Import lastlog data into lastlog2 database.1780worker # [ 8.581327] systemd[1]: Reached target Host and Network Name Lookups.1781worker # [ 8.584106] systemd[1]: Reached target User and Group Name Lookups.1782hub # [ 11.897428] tailscaled[615]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1783hub # [ 11.899641] tailscaled[615]: dns: using "openresolv" mode1784worker # [ 8.594137] systemd[1]: Starting D-Bus System Message Bus...1785hub # [ 11.908785] tailscaled[615]: dns: using dns.openresolvManager1786hub # [ 11.910589] tailscaled[615]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true}1787hub # [ 11.921441] tailscaled[615]: magicsock: disco key = d:8877a9d90af272f71788hub # [ 11.923600] tailscaled[615]: Creating WireGuard device...1789worker # [ 8.614619] systemd[1]: Starting User Login Management...1790hub # [ 11.927513] tailscaled[615]: Bringing WireGuard device up...1791hub # [ 11.936996] tailscaled[615]: external route: up1792hub # [ 11.938896] tailscaled[615]: router: portUpdate(port=41641, network=udp6)1793hub # [ 11.940944] tailscaled[615]: router: using firewall mode pref1794hub # [ 11.955845] tailscaled[615]: Bringing router up...1795hub # [ 11.986710] tailscaled[615]: router: default choosing iptables1796worker # [ 8.690599] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'...1797worker # [ 8.695116] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync'1798worker # [ 8.698414] 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"1799worker # [ 8.710332] systemd[1]: Started D-Bus System Message Bus.1800hub # [ 12.036956] tailscaled[615]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1801hub # [ 12.039361] tailscaled[615]: router: portUpdate(port=41641, network=udp4)1802hub # [ 12.047341] tailscaled[615]: Clearing router settings...1803hub # [ 12.049123] tailscaled[615]: Starting network monitor...1804worker # [ 8.741451] dbus-broker-launch[530]: Ready1805hub # [ 12.053219] tailscaled[615]: Engine created.1806worker # [ 8.759417] systemd-logind[537]: New seat seat0.1807worker # [ 8.765106] systemd[1]: Started User Login Management.1808hub # [ 12.075117] tailscaled[615]: pm: migrating "_daemon" profile to new format1809hub # [ 12.077530] tailscaled[615]: envknob: PORT="41641"1810worker # [ 8.770577] systemd[1]: Stopped target Host and Network Name Lookups.1811worker # [ 8.772277] systemd[1]: Stopping Host and Network Name Lookups...1812worker # [ 8.773821] systemd[1]: Stopped target User and Group Name Lookups.1813hub # [ 12.084469] tailscaled[615]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1814worker # [ 8.775440] systemd[1]: Stopping User and Group Name Lookups...1815hub # [ 12.087749] tailscaled[615]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1816worker # [ 8.781262] systemd[1]: Starting linger-users.service...1817hub # [ 12.094565] tailscaled[615]: got LocalBackend in 304ms1818hub # [ 12.096404] tailscaled[615]: Start1819worker # [ 8.786793] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1820hub # [ 12.097512] tailscaled[615]: ipnext: "conn25": skipping extension1821hub # [ 12.099559] tailscaled[615]: ipnext: active extensions: clientupdate, relayserver, taildrop, conn25, portlist, posture1822worker # [ 8.790520] systemd[1]: nscd.service: Deactivated successfully.1823hub # [ 12.106816] tailscaled[615]: profile data directory: profile not found1824worker # [ 8.798273] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1825hub # [ 12.110204] tailscaled[615]: Backend: logs: be:86b92cbc5a27063c523a7074b973c8b3780c6319a14022c67168268c00ca7598 fe:1826worker # [ 8.799866] systemd[1]: nscd.service: Consumed 17ms CPU time over 355ms wall clock time, 6.8M memory peak, 5.5M read from disk.1827hub # [ 12.115521] tailscaled[615]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1828hub # [ 12.117641] tailscaled[615]: blockEngineUpdates(true)1829hub # [ 12.120575] tailscaled[615]: wgengine: Reconfig: configuring router1830hub # [ 12.122775] tailscaled[615]: wgengine: Reconfig: user dialer1831hub # [ 12.124535] tailscaled[615]: wgengine: Reconfig: configuring DNS1832hub # [ 12.126662] tailscaled[615]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1833hub # [ 12.128892] tailscaled[615]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1834hub # [ 12.130769] tailscaled[615]: dns: OScfg: {}1835hub # [ 12.136449] tailscaled[615]: health(warnable=wantrunning-false): error: Tailscale is stopped.1836worker # [ 8.839121] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1837worker # [ 8.847094] systemd[1]: Finished resolvconf update.1838worker # [ 8.852108] systemd[1]: linger-users.service: Deactivated successfully.1839worker # [ 8.856707] systemd[1]: Finished linger-users.service.1840worker # [ 8.867151] systemd[1]: Reached target Preparation for Network.1841worker # [ 8.876683] systemd[1]: Starting DHCP Client...1842worker # [ 8.890841] systemd[1]: Starting Address configuration of eth1...1843worker # [ 8.893381] nsncd[584]: Jul 13 09:24:07.214 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1844worker # [ 8.906787] systemd[1]: Starting Extra networking commands....1845worker # [ 8.916092] systemd[1]: Starting Tailscale node agent...1846worker # [ 8.920625] systemd[1]: Started Name Service Cache Daemon (nsncd).1847worker # [ 8.932101] systemd[1]: Reached target Host and Network Name Lookups.1848worker # [ 8.941102] systemd[1]: Reached target User and Group Name Lookups.1849worker # [ 9.211923] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31850worker # [ 9.004331] network-addresses-eth1-start[589]: adding address 192.168.1.2/24... done1851worker # [ 9.017333] network-addresses-eth1-start[589]: adding address 2001:db8:1::2/64... done1852hub # [ 12.350319] dhcpcd[677]: eth0: soliciting an IPv6 router1853hub # [ 12.352676] dhcpcd[677]: eth0: Router Advertisement from fe80::21854hub # [ 12.354504] tailscaled[615]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2541855hub # [ 12.356827] tailscaled[615]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2541856worker # [ 9.047433] systemd[1]: Finished Address configuration of eth1.1857hub # [ 12.358918] dhcpcd[677]: eth0: adding address fec0::5054:ff:fe12:3456/641858hub # [ 12.360616] dhcpcd[677]: eth0: adding route to fec0::/641859hub # [ 12.362074] dhcpcd[677]: eth0: adding default route via fe80::21860hub # [ 12.374124] systemd-vconsole-setup[770]: Configuration of first virtual console was skipped, ignoring remaining ones.1861hub # [ 12.379726] systemd[1]: Finished Virtual Console Setup.1862worker # [ 9.333910] mousedev: PS/2 mouse device common for all mice1863worker # [ 9.382202] ACPI: button: Power Button [PWRF]1864worker # [ 9.194361] dhcpcd[618]: dhcpcd-10.3.2 starting1865worker # [ 9.207547] dhcpcd[658]: dev: loaded udev1866worker # [ 9.460377] 8021q: 802.1Q VLAN Support v1.81867worker # [ 9.463560] rtc_cmos 00:05: RTC can wake from S41868worker # [ 9.468542] 8021q: adding VLAN 0 to HW filter on device eth11869worker # [ 9.232233] systemd[1]: Finished Extra networking commands..1870worker # [ 9.233777] systemd[1]: Reached target Network.1871worker # [ 9.243566] systemd[1]: Starting Permit User Sessions...1872worker # [ 9.253161] tailscaled[601]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1873worker # [ 9.265122] tailscaled[601]: logtail started1874worker # [ 9.266340] tailscaled[601]: 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"}1875worker # [ 9.271410] tailscaled[601]: LogID: 6953f85ed0167f204a3eb76db55679d1a16315d6942805feaffe58c10f8e6a881876worker # [ 9.273455] tailscaled[601]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1877worker # [ 9.278288] tailscaled[601]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1878worker # [ 9.281478] tailscaled[601]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1879worker # [ 9.292419] tailscaled[601]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:40668->[::1]:53: read: connection refused (in 15ms), trying bootstrap...1880worker # [ 9.540880] Floppy drive(s): fd0 is 2.88M AMI BIOS1881worker # [ 9.306941] tailscaled[601]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ...1882worker # [ 9.311605] dbus-broker-launch[530]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1883worker # [ 9.319083] tailscaled[601]: bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.94.167:443: connect: network is unreachable1884worker # [ 9.323735] tailscaled[601]: trying bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" ...1885worker # [ 9.326847] tailscaled[601]: bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::44c]:443: connect: network is unreachable1886worker # [ 9.333161] tailscaled[601]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...1887worker # [ 9.338233] tailscaled[601]: 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 unreachable1888worker # [ 9.342831] tailscaled[601]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ...1889worker # [ 9.345363] tailscaled[601]: 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 unreachable1890worker # [ 9.353115] tailscaled[601]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ...1891worker # [ 9.355457] tailscaled[601]: bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 45.63.71.144:443: connect: network is unreachable1892worker # [ 9.359869] tailscaled[601]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ...1893worker # [ 9.362597] tailscaled[601]: 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 unreachable1894worker # [ 9.371483] systemd[1]: Finished Permit User Sessions.1895worker # [ 9.372902] tailscaled[601]: trying bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" ...1896worker # [ 9.375343] tailscaled[601]: bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 155.138.243.219:443: connect: network is unreachable1897worker # [ 9.382253] tailscaled[601]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ...1898worker # [ 9.384849] tailscaled[601]: bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:100:d0::982:d001]:443: connect: network is unreachable1899worker # [ 9.390939] tailscaled[601]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ...1900worker # [ 9.394125] tailscaled[601]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable1901worker # [ 9.399241] systemd[1]: Started Getty on tty1.1902worker # [ 9.402707] tailscaled[601]: trying bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" ...1903worker # [ 9.406131] tailscaled[601]: 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 unreachable1904worker # [ 9.412719] tailscaled[601]: trying bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" ...1905worker # [ 9.415147] tailscaled[601]: 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 unreachable1906worker # [ 9.421146] tailscaled[601]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...1907worker # [ 9.423636] tailscaled[601]: 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 unreachable1908worker # [ 9.430991] systemd[1]: Reached target Login Prompts.1909worker # [ 9.435091] tailscaled[601]: logtail: upload: log upload of 478 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/50ceec509c1cb1c59efdad2f1ea18b433ab0a98e07769e01b562331982c9b050": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1910worker # [ 9.455237] tailscaled[601]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1911worker # [ 9.698890] rtc_cmos 00:05: registered as rtc01912worker # [ 9.458971] tailscaled[601]: dns: using "openresolv" mode1913worker # [ 9.460404] tailscaled[601]: dns: using dns.openresolvManager1914worker # [ 9.703283] rtc_cmos 00:05: setting system clock to 2026-07-13T09:24:07 UTC (1783934647)1915worker # [ 9.705514] systemd-journald[276]: Time jumped backwards, rotating.1916worker # [ 9.728936] parport_pc 00:03: reported by Plug and Play ACPI1917worker # [ 9.771445] FDC 0 is a S82078B1918worker # [ 9.795428] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1919worker # [ 9.809403] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1920worker # [ 9.850579] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1921worker # [ 9.856787] cfg80211: Loading compiled-in X.509 certificates for regulatory database1922worker # [ 9.868502] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1923worker # [ 9.869969] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1924worker # [ 9.878702] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21925worker # [ 9.880772] cfg80211: failed to load regulatory.db1926worker # [ 9.695600] dhcpcd[658]: eth0: waiting for carrier1927worker # [ 9.699586] systemd[1]: Started Tailscale node agent.1928worker # [ 9.703313] tailscaled[601]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1929worker # [ 9.705332] dhcpcd[658]: eth0: carrier acquired1930worker # [ 9.712713] dhcpcd[658]: DUID 00:01:00:01:31:e7:6b:37:52:54:00:12:34:561931worker # [ 9.714466] dhcpcd[658]: eth0: IAID 00:12:34:561932worker # [ 9.716955] dhcpcd[658]: eth0: adding address fe80::5054:ff:fe12:34561933worker # [ 9.746815] tailscaled[601]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1934worker # [ 9.748967] tailscaled[601]: dns: using "openresolv" mode1935worker # [ 9.757142] tailscaled[601]: dns: using dns.openresolvManager1936worker # [ 9.758796] tailscaled[601]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true}1937worker # [ 9.764649] tailscaled[601]: magicsock: disco key = d:833c6797204583791938worker # [ 9.767244] tailscaled[601]: Creating WireGuard device...1939worker # [ 9.769542] tailscaled[601]: Bringing WireGuard device up...1940worker # [ 9.772495] tailscaled[601]: Bringing router up...1941worker # [ 9.774560] tailscaled[601]: router: using firewall mode pref1942worker # [ 9.783103] tailscaled[601]: external route: up1943worker # [ 9.909500] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01944hub # [ 13.081839] tailscaled[615]: 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::8bd9:36ff:3277:1211/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::8bd9:36ff:3277:1211/64] rebind-reason=[default-if-changed]1945worker # [ 9.798921] tailscaled[601]: router: portUpdate(port=41641, network=udp6)1946hub # [ 13.107602] tailscaled[615]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1947hub # [ 13.114372] tailscaled[615]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1948hub # [ 13.118988] tailscaled[615]: dns: OScfg: {}1949worker # [ 9.811217] tailscaled[601]: router: default choosing iptables1950worker # [ 9.832102] tailscaled[601]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1951worker # [ 9.836658] tailscaled[601]: Clearing router settings...1952worker # [ 9.838228] tailscaled[601]: Starting network monitor...1953worker # [ 9.840486] tailscaled[601]: Engine created.1954worker # [ 9.842931] tailscaled[601]: router: portUpdate(port=41641, network=udp4)1955worker # [ 9.853106] tailscaled[601]: pm: migrating "_daemon" profile to new format1956worker # [ 9.854947] tailscaled[601]: envknob: PORT="41641"1957worker # [ 9.857758] tailscaled[601]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1958worker # [ 9.860457] tailscaled[601]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1959worker # [ 9.866528] tailscaled[601]: got LocalBackend in 168ms1960worker # [ 9.868278] tailscaled[601]: Start1961worker # [ 9.870125] tailscaled[601]: ipnext: "conn25": skipping extension1962worker # [ 9.871631] tailscaled[601]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop1963worker # [ 9.874949] tailscaled[601]: profile data directory: profile not found1964hub # [ 13.186123] tailscaled[615]: wgengine: set DNS config again after major link change1965worker # [ 9.877120] tailscaled[601]: Backend: logs: be:6953f85ed0167f204a3eb76db55679d1a16315d6942805feaffe58c10f8e6a88 fe:1966hub # [ 13.188064] tailscaled[615]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::8bd9:36ff:3277:1211/64]1967worker # [ 9.879454] tailscaled[601]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1968hub # [ 13.190806] tailscaled[615]: magicsock: 0 active derp conns1969hub # [ 13.192209] tailscaled[615]: router: portUpdate(port=41641, network=udp6)1970worker # [ 9.883179] tailscaled[601]: blockEngineUpdates(true)1971hub # [ 13.194209] tailscaled[615]: router: portUpdate(port=41641, network=udp4)1972worker # [ 9.885232] tailscaled[601]: wgengine: Reconfig: configuring router1973worker # [ 9.887162] tailscaled[601]: wgengine: Reconfig: user dialer1974worker # [ 9.888596] tailscaled[601]: wgengine: Reconfig: configuring DNS1975worker # [ 9.890103] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1976worker # [ 9.892934] tailscaled[601]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1977worker # [ 9.896176] tailscaled[601]: dns: OScfg: {}1978worker # [ 9.904193] tailscaled[601]: health(warnable=wantrunning-false): error: Tailscale is stopped.1979worker # [ 9.909563] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1980worker # [ 9.923571] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41981worker # [ 9.933636] 8021q: adding VLAN 0 to HW filter on device eth01982worker # [ 9.957855] tun: Universal TUN/TAP device driver, 1.61983worker # [ 9.986622] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61984worker # [ 9.986992] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51985worker # [ 9.983440] systemd[1]: Starting Virtual Console Setup...1986worker # [ 10.035552] Console: switching to colour dummy device 80x251987worker # [ 10.277399] [drm] Found bochs VGA, ID 0xb0c5.1988worker # [ 10.277401] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1989worker # [ 10.032419] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1990worker # [ 10.049536] systemd-logind[537]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1991worker # [ 10.306333] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1992worker # [ 10.307670] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01993worker # [ 10.098650] systemd-vconsole-setup[728]: Configuration of first virtual console was skipped, ignoring remaining ones.1994worker # [ 10.344250] ppdev: user-space parallel port driver1995worker # [ 10.104448] systemd[1]: Finished Virtual Console Setup.1996worker # [ 10.114086] systemd-logind[537]: Watching system buttons on /dev/input/event2 (Power Button)1997worker # [ 10.138935] (udev-worker)[398]: Network interface NamePolicy= disabled on kernel command line.1998worker # [ 10.141572] dhcpcd[658]: eth0: soliciting a DHCP lease1999worker # [ 10.387711] NET: Registered PF_PACKET protocol family2000worker # [ 10.155632] dhcpcd[658]: eth0: offered 10.0.2.15 from 10.0.2.22001worker # [ 10.158225] dhcpcd[658]: eth0: probing address 10.0.2.15/242002worker # [ 10.183229] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2003worker # [ 10.185432] systemd[1]: Stopped Virtual Console Setup.2004worker # [ 10.187501] systemd[1]: Stopping Virtual Console Setup...2005worker # [ 10.195306] systemd[1]: Starting Virtual Console Setup...2006worker # [ 10.442194] fbcon: bochs-drmdrmfb (fb0) is primary device2007worker # [ 10.499372] Console: switching to colour frame buffer device 160x502008worker # [ 10.506169] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device2009worker # [ 10.236612] systemd-logind[537]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2010worker # [ 10.272670] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2011worker # [ 10.274731] systemd[1]: Stopped Virtual Console Setup.2012worker # [ 10.286676] systemd[1]: Starting Virtual Console Setup...2013worker # [ 10.332601] systemd-vconsole-setup[738]: Configuration of first virtual console was skipped, ignoring remaining ones.2014worker # [ 10.339871] systemd[1]: Finished Virtual Console Setup.2015worker # [ 10.613269] kvm_amd: TSC scaling supported2016worker # [ 10.614017] kvm_amd: Nested Virtualization enabled2017worker # [ 10.615293] kvm_amd: Nested Paging enabled2018worker # [ 10.616017] kvm_amd: LBR virtualization supported2019worker # [ 10.617223] kvm_amd: Virtual VMLOAD VMSAVE supported2020worker # [ 10.618574] kvm_amd: Virtual GIF supported2021worker # [ 10.619542] kvm_amd: Virtual NMI enabled2022worker # [ 10.649748] EDAC MC: Ver: 3.0.02023hub # [ 14.199818] tailscaled[615]: monitor: RTM_NEWROUTE: src=, dst=fec0::8bd9:36ff:3277:1211/128, gw=, outif=2, table=2552024hub # [ 14.328713] tailscaled[615]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552025worker # [ 11.809256] dhcpcd[658]: eth0: soliciting an IPv6 router2026worker # [ 11.815234] dhcpcd[658]: eth0: Router Advertisement from fe80::22027worker # [ 11.820756] dhcpcd[658]: eth0: adding address fec0::5054:ff:fe12:3456/642028worker # [ 11.825973] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2542029worker # [ 11.831620] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2542030worker # [ 11.837262] dhcpcd[658]: eth0: adding route to fec0::/642031worker # [ 11.840911] dhcpcd[658]: eth0: adding default route via fe80::22032worker # [ 11.863931] tailscaled[601]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64] rebind-reason=[default-if-changed]2033worker # [ 11.887727] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2034worker # [ 11.892913] tailscaled[601]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2035worker # [ 11.897142] tailscaled[601]: dns: OScfg: {}2036worker # [ 11.909658] tailscaled[601]: wgengine: set DNS config again after major link change2037worker # [ 11.912809] tailscaled[601]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64]2038worker # [ 11.916197] tailscaled[601]: magicsock: 0 active derp conns2039worker # [ 11.918896] tailscaled[601]: router: portUpdate(port=41641, network=udp6)2040worker # [ 11.921069] tailscaled[601]: router: portUpdate(port=41641, network=udp4)2041hub # [ 16.192633] dhcpcd[677]: eth0: leased 10.0.2.15 for 86400 seconds2042hub # [ 16.200684] dhcpcd[677]: eth0: adding route to 10.0.2.0/242043hub # [ 16.208805] tailscaled[615]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552044hub # [ 16.215412] tailscaled[615]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552045hub # [ 16.222453] dhcpcd[677]: eth0: adding default route via 10.0.2.22046hub # [ 16.226803] tailscaled[615]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542047hub # [ 16.234335] tailscaled[615]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542048hub # [ 16.244395] tailscaled[615]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::8bd9:36ff:3277:1211/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::8bd9:36ff:3277:1211/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::8bd9:36ff:3277:1211/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::8bd9:36ff:3277:1211/64] rebind-reason=[ips-changed]2049hub # [ 16.278420] tailscaled[615]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2050hub # [ 16.280614] tailscaled[615]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2051hub # [ 16.282635] tailscaled[615]: dns: OScfg: {}2052hub # [ 16.389410] systemd[1]: Started DHCP Client.2053hub # [ 16.392507] systemd[1]: Reached target Network is Online.2054hub # [ 16.398476] systemd[1]: Started headscale coordination server for Tailscale.2055hub # [ 16.400855] systemd[1]: Reached target Multi-User System.2056hub # [ 16.403227] systemd[1]: Startup finished in 998ms (kernel) + 4.333s (initrd) + 11.070s (userspace) = 16.402s.2057worker # [ 13.363939] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=fec0::b686:e8f3:e087:c001/128, gw=, outif=2, table=2552058hub # [ 16.872834] headscale-start[885]: 2026-07-13T09:24:11Z WRN2059hub # [ 16.874727] headscale-start[885]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed.2060hub # [ 16.881731] headscale-start[885]: 2026-07-13T09:24:11Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key2061hub # [ 16.891691] headscale-start[885]: 2026-07-13T09:24:11Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite2062hub: (finished: waiting for unit headscale, in 14.58 seconds)2063hub: waiting for TCP port 443 on localhost2064worker # [ 13.619650] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552065hub # [ 17.009201] headscale-start[885]: 2026-07-13T09:24:11Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key2066hub # [ 17.020113] headscale-start[885]: 2026-07-13T09:24:11Z INF starting headscale commit=v0.29.2 version=0.29.22067hub # [ 17.022741] headscale-start[885]: 2026-07-13T09:24:11Z INF Clients with a lower minimum version will be rejected minimum_version=v1.802068hub # Connection to localhost (::1) 443 port [tcp/https] succeeded!2069hub # [ 17.033132] headscale-start[885]: 2026-07-13T09:24:11Z INF stun server started at [::]:34782070hub: (finished: waiting for TCP port 443 on localhost, in 0.11 seconds)2071hub: waiting for unit tailscaled2072hub # [ 17.038060] headscale-start[885]: 2026-07-13T09:24:11Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:144 > derp region: {RegionID:999 RegionCode: RegionName: Latitude:0 Longitude:0 Avoid:false NoMeasureNoHome:false Nodes:[0xba6cbc22120]}2073hub # [ 17.043333] headscale-start[885]: 2026-07-13T09:24:11Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:145 > derp nodes[0]: &{Name:999 RegionID:999 HostName:hub CertName: IPv4: IPv6: STUNPort:3478 STUNOnly:false DERPPort:443 InsecureForTests:false STUNTestIP: CanPort80:false}2074hub # [ 17.052772] headscale-start[885]: 2026-07-13T09:24:11Z INF HA subnet router health probing enabled interval=10000 timeout=50002075hub # [ 17.066431] headscale-start[885]: 2026-07-13T09:24:11Z WRN listening without TLS but ServerURL does not start with http://2076hub # [ 17.078442] headscale-start[885]: 2026-07-13T09:24:11Z INF listening and serving HTTP on: 127.0.0.1:80802077hub # [ 17.080934] headscale-start[885]: 2026-07-13T09:24:11Z INF metrics server disabled (metrics_listen_addr is empty)2078hub: (finished: waiting for unit tailscaled, in 0.09 seconds)2079worker: waiting for unit tailscaled2080worker: waiting for the VM to finish booting2081worker: Guest shell says: b'Spawning backdoor root shell...\n'2082worker: connected to guest root shell2083worker: (connecting took 0.00 seconds)2084worker: (finished: waiting for the VM to finish booting, in 0.00 seconds)2085worker: (finished: waiting for unit tailscaled, in 0.05 seconds)2086hub: must succeed: headscale users create test2087hub # [ 17.261427] headscale-start[885]: 2026-07-13T09:24:12Z INF user created user.name=test2088hub: (finished: must succeed: headscale users create test, in 0.10 seconds)2089hub: must succeed: headscale preauthkeys -u 1 create --reusable2090hub # [ 17.357666] tailscaled[615]: wgengine: set DNS config again after major link change2091hub # [ 17.362061] tailscaled[615]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::8bd9:36ff:3277:1211/64]2092hub # [ 17.365043] tailscaled[615]: magicsock: 0 active derp conns2093hub # [ 17.371729] tailscaled[615]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152094hub # [ 17.375959] tailscaled[615]: router: portUpdate(port=41641, network=udp6)2095hub # [ 17.384273] tailscaled[615]: router: portUpdate(port=41641, network=udp4)2096hub # [ 17.385937] tailscaled[615]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2097hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.16 seconds)2098hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-toek6U_wW9zc-PQhvLHMouLOHZnCm0R6QiwQKcUQ9NF7DmBxFoiQwFtVHdIUPSmo54as0Iu8i3vsi --hostname hub2099hub # [ 17.502844] tailscaled[615]: localapi: [POST] /localapi/v0/check-prefs2100hub # [ 17.506615] tailscaled[615]: localapi: [POST] /localapi/v0/start2101hub # [ 17.508167] tailscaled[615]: Start2102hub # [ 17.509411] tailscaled[615]: 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]2103hub # [ 17.513730] tailscaled[615]: generating new machine key2104hub # [ 17.520144] tailscaled[615]: machine key written to store2105hub # [ 17.521769] tailscaled[615]: profile data directory: profile not found2106hub # [ 17.525902] tailscaled[615]: Backend: logs: be:86b92cbc5a27063c523a7074b973c8b3780c6319a14022c67168268c00ca7598 fe:2107hub # [ 17.534381] tailscaled[615]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2108hub # [ 17.536503] tailscaled[615]: blockEngineUpdates(true)2109hub # [ 17.537765] tailscaled[615]: Reconfig(down): no changes made to Engine config2110hub # [ 17.541102] tailscaled[615]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2111hub # [ 17.543439] tailscaled[615]: health(warnable=wantrunning-false): ok2112hub # [ 17.545771] tailscaled[615]: control: client.Shutdown ...2113hub # [ 17.547190] tailscaled[615]: control: updateRoutine: exiting2114hub # [ 17.548619] tailscaled[615]: control: authRoutine: exiting2115hub # [ 17.550119] tailscaled[615]: control: mapRoutine: exiting2116hub # [ 17.551767] tailscaled[615]: control: Client.Shutdown done.2117hub # [ 17.554566] tailscaled[615]: localapi: [POST] /localapi/v0/login-interactive2118hub # [ 17.556610] tailscaled[615]: StartLoginInteractiveAs("root"): url=false2119hub # [ 17.558272] tailscaled[615]: control: client.Login(2)2120hub # [ 17.560864] tailscaled[615]: control: LoginInteractive -> regen=true2121hub # [ 17.562625] tailscaled[615]: control: doLogin(regen=true, hasUrl=false)2122hub # [ 17.636425] tailscaled[615]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2123hub # [ 17.654148] headscale-start[885]: 2026-07-13T09:24:12Z INF http request bytes=176 elapsed=3.243988 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:35786 status=2002124hub # [ 17.661626] tailscaled[615]: control: control server key from https://hub: ts2021=[Fcm/y], legacy=2125hub # [ 17.664523] tailscaled[615]: control: Generating a new nodekey.2126hub # [ 17.669430] tailscaled[615]: control: RegisterReq: onode= node=[dxibG] fup=false nks=false2127hub # [ 18.548393] headscale-start[885]: 2026-07-13T09:24:13Z INF http request bytes=249 elapsed=855.888946 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:35800 status=2002128hub # [ 18.561477] tailscaled[615]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2129hub # [ 18.581518] tailscaled[615]: blockEngineUpdates(false)2130worker # [ 15.402643] dhcpcd[658]: eth0: leased 10.0.2.15 for 86400 seconds2131worker # [ 15.411937] dhcpcd[658]: eth0: adding route to 10.0.2.0/242132worker # [ 15.420323] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552133worker # [ 15.426923] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552134worker # [ 15.434333] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542135worker # [ 15.441111] dhcpcd[658]: eth0: adding default route via 10.0.2.22136worker # [ 15.446720] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542137worker # [ 15.456753] tailscaled[601]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64] rebind-reason=[ips-changed]2138worker # [ 15.479443] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2139worker # [ 15.481475] tailscaled[601]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2140worker # [ 15.484124] tailscaled[601]: dns: OScfg: {}2141worker # [ 15.537409] systemd[1]: Started DHCP Client.2142worker # [ 15.540923] systemd[1]: Reached target Multi-User System.2143worker # [ 15.542852] systemd[1]: Startup finished in 989ms (kernel) + 4.684s (initrd) + 9.868s (userspace) = 15.542s.2144hub # [ 19.052555] headscale-start[885]: 2026-07-13T09:24:13Z INF http request bytes=0 elapsed=459.613163 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35800 status=2002145hub # [ 19.554820] headscale-start[885]: 2026-07-13T09:24:14Z INF node connected machine.key=[zgKtM] node.expired=false node.id=1 node.is_tagged=false node.key=[dxibG] node.name=hub node.online=true user.name=test2146hub # [ 19.567257] headscale-start[885]: 2026-07-13T09:24:14Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0xba6cb988a10 component=poll machine.key=[zgKtM] node.expired=false node.id=1 node.is_tagged=false node.key=[dxibG] node.name=hub node.online=false omit_peers=false stream=true user.name=test2147hub # [ 19.637335] tailscaled[615]: health(warnable=not-in-map-poll): ok2148hub # [ 19.649370] tailscaled[615]: active login: test2149hub # [ 19.658520] tailscaled[615]: netmap: suggested exit node: no preferred DERP, try again later2150hub # [ 19.660504] tailscaled[615]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2151hub # [ 19.664579] tailscaled[615]: magicsock: SetPrivateKey called (init)2152hub # [ 19.666656] tailscaled[615]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers)2153hub # [ 19.673236] tailscaled[615]: wgengine: Reconfig: configuring router2154worker # [ 16.520930] tailscaled[601]: wgengine: set DNS config again after major link change2155worker # [ 16.530242] tailscaled[601]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::b686:e8f3:e087:c001/64]2156worker # [ 16.538394] tailscaled[601]: magicsock: 0 active derp conns2157worker # [ 16.547790] tailscaled[601]: router: portUpdate(port=41641, network=udp6)2158worker # [ 16.553585] tailscaled[601]: router: portUpdate(port=41641, network=udp4)2159worker # [ 16.558580] tailscaled[601]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2160worker # [ 16.566351] tailscaled[601]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152161hub # [ 19.908288] tailscaled[615]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [14ms] (forced=false)2162hub # [ 19.911225] tailscaled[615]: magicsock: home is now derp-999 ()2163hub # [ 19.914276] tailscaled[615]: 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::8bd9:36ff:3277:1211]:41641 (local)2164hub # [ 19.919623] tailscaled[615]: magicsock: adding connection to derp-999 for home-keep-alive2165hub # [ 19.922384] tailscaled[615]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2166hub # [ 19.924645] tailscaled[615]: derphttp.Client.Connect: connecting to derp-999 ()2167hub # [ 19.932102] tailscaled[615]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2168hub # [ 19.954641] tailscaled[615]: magicsock: derp-999 connected; connGen=12169hub # [ 20.314969] tailscaled[615]: router: enabling connmark-based rp_filter workaround2170hub # [ 20.446206] tailscaled[615]: wgengine: Reconfig: user dialer2171hub # [ 20.448727] tailscaled[615]: tsdial: bart table size: 22172hub # [ 20.450458] tailscaled[615]: wgengine: Reconfig: configuring DNS2173hub # [ 20.452169] tailscaled[615]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1}2174hub # [ 20.514243] tailscaled[615]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa}2175hub # [ 20.516831] tailscaled[615]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2176hub # [ 20.615811] systemd[1]: Stopped target Host and Network Name Lookups.2177hub # [ 20.619620] systemd[1]: Stopping Host and Network Name Lookups...2178hub # [ 20.622264] systemd[1]: Stopped target User and Group Name Lookups.2179hub # [ 20.624133] systemd[1]: Stopping User and Group Name Lookups...2180hub # [ 20.627259] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2181hub # [ 20.628995] systemd[1]: nscd.service: Deactivated successfully.2182hub # [ 20.632119] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2183hub # [ 20.643867] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2184hub # [ 20.681864] tailscaled[615]: peerapi: serving on http://100.64.0.1:584362185hub # [ 20.684157] tailscaled[615]: peerapi: serving on http://[fd7a:115c:a1e0::1]:597802186hub # [ 20.689064] tailscaled[615]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2187hub # [ 20.691165] tailscaled[615]: netmap: suggested exit node: ()2188hub # [ 20.700220] tailscaled[615]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2189hub # [ 20.704668] tailscaled[615]: writing netmap to disk cache2190hub # [ 20.709333] nsncd[1034]: Jul 13 09:24:15.485 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2191hub # [ 20.712807] systemd[1]: Started Name Service Cache Daemon (nsncd).2192hub # [ 20.716710] systemd[1]: Reached target Host and Network Name Lookups.2193hub # [ 20.718786] systemd[1]: Reached target User and Group Name Lookups.2194hub # [ 20.721723] tailscaled[615]: health(warnable=no-derp-connection): ok2195hub # [ 20.723607] tailscaled[615]: health(warnable=no-derp-connection): ok2196hub # [ 20.725756] tailscaled[615]: health(warnable=warming-up): ok2197hub # [ 20.727444] tailscaled[615]: [RATELIMIT] format("health(warnable=%s): ok")2198hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-toek6U_wW9zc-PQhvLHMouLOHZnCm0R6QiwQKcUQ9NF7DmBxFoiQwFtVHdIUPSmo54as0Iu8i3vsi --hostname hub, in 3.31 seconds)2199worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-toek6U_wW9zc-PQhvLHMouLOHZnCm0R6QiwQKcUQ9NF7DmBxFoiQwFtVHdIUPSmo54as0Iu8i3vsi --hostname tt-worker2200worker # [ 17.482889] tailscaled[601]: localapi: [POST] /localapi/v0/check-prefs2201worker # [ 17.485545] tailscaled[601]: localapi: [POST] /localapi/v0/start2202worker # [ 17.487650] tailscaled[601]: Start2203worker # [ 17.491918] tailscaled[601]: 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]2204worker # [ 17.499068] tailscaled[601]: generating new machine key2205worker # [ 17.504591] tailscaled[601]: machine key written to store2206worker # [ 17.506290] tailscaled[601]: profile data directory: profile not found2207worker # [ 17.508678] tailscaled[601]: Backend: logs: be:6953f85ed0167f204a3eb76db55679d1a16315d6942805feaffe58c10f8e6a88 fe:2208worker # [ 17.513745] tailscaled[601]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2209worker # [ 17.515831] tailscaled[601]: blockEngineUpdates(true)2210worker # [ 17.517146] tailscaled[601]: Reconfig(down): no changes made to Engine config2211worker # [ 17.520085] tailscaled[601]: control: client.Shutdown ...2212worker # [ 17.521760] tailscaled[601]: control: mapRoutine: exiting2213worker # [ 17.523274] tailscaled[601]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2214worker # [ 17.525609] tailscaled[601]: health(warnable=wantrunning-false): ok2215worker # [ 17.527608] tailscaled[601]: control: authRoutine: exiting2216worker # [ 17.528958] tailscaled[601]: control: updateRoutine: exiting2217worker # [ 17.530445] tailscaled[601]: control: Client.Shutdown done.2218worker # [ 17.534106] tailscaled[601]: localapi: [POST] /localapi/v0/login-interactive2219worker # [ 17.535790] tailscaled[601]: StartLoginInteractiveAs("root"): url=false2220worker # [ 17.537361] tailscaled[601]: control: client.Login(2)2221worker # [ 17.538632] tailscaled[601]: control: LoginInteractive -> regen=true2222worker # [ 17.540190] tailscaled[601]: control: doLogin(regen=true, hasUrl=false)2223worker # [ 17.565083] tailscaled[601]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2224hub # [ 20.883806] headscale-start[885]: 2026-07-13T09:24:15Z INF http request bytes=176 elapsed=1.194566 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:35818 status=2002225worker # [ 17.582859] tailscaled[601]: control: control server key from https://hub: ts2021=[Fcm/y], legacy=2226worker # [ 17.585526] tailscaled[601]: control: Generating a new nodekey.2227worker # [ 17.589421] tailscaled[601]: control: RegisterReq: onode= node=[ZBfix] fup=false nks=false2228hub # [ 21.060117] headscale-start[885]: 2026-07-13T09:24:15Z INF http request bytes=0 elapsed=362.157201 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35800 status=2002229hub # [ 21.566104] headscale-start[885]: 2026-07-13T09:24:16Z INF http request bytes=0 elapsed=490.078208 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35800 status=2002230hub # [ 21.577168] headscale-start[885]: 2026-07-13T09:24:16Z INF http request bytes=249 elapsed=657.708731 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:35832 status=2002231worker # [ 18.278270] tailscaled[601]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2232worker # [ 18.291471] tailscaled[601]: blockEngineUpdates(false)2233hub # [ 21.846811] tailscaled[615]: netmap: suggested exit node: ()2234hub # [ 21.857251] tailscaled[615]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2235hub # [ 21.869649] tailscaled[615]: netmap: suggested exit node: ()2236hub # [ 21.874135] tailscaled[615]: wgengine: Reconfig: user dialer2237hub # [ 21.877151] tailscaled[615]: tsdial: bart table size: 22238hub # [ 21.880781] tailscaled[615]: wgengine: Reconfig: configuring DNS2239hub # [ 21.883661] tailscaled[615]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2240hub # [ 21.952080] tailscaled[615]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2241hub # [ 21.954979] tailscaled[615]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2242hub # [ 22.061992] headscale-start[885]: 2026-07-13T09:24:16Z INF http request bytes=0 elapsed=459.25809 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35832 status=2002243hub # [ 22.562275] headscale-start[885]: 2026-07-13T09:24:17Z INF node connected machine.key=[ePfFv] node.expired=false node.id=2 node.is_tagged=false node.key=[ZBfix] node.name=tt-worker node.online=true user.name=test2244hub # [ 22.572227] headscale-start[885]: 2026-07-13T09:24:17Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0xba6cb955b20 component=poll machine.key=[ePfFv] node.expired=false node.id=2 node.is_tagged=false node.key=[ZBfix] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test2245worker # [ 19.301492] tailscaled[601]: health(warnable=not-in-map-poll): ok2246worker # [ 19.323571] tailscaled[601]: active login: test2247hub # [ 22.637824] tailscaled[615]: netmap: suggested exit node: ()2248worker # [ 19.330097] tailscaled[601]: netmap: suggested exit node: no preferred DERP, try again later2249worker # [ 19.332965] tailscaled[601]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2250worker # [ 19.335363] tailscaled[601]: magicsock: SetPrivateKey called (init)2251worker # [ 19.337043] tailscaled[601]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2252worker # [ 19.339433] tailscaled[601]: wgengine: Reconfig: configuring router2253hub # [ 22.651305] tailscaled[615]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2254hub # [ 22.656613] tailscaled[615]: wgengine: Reconfig: configuring router2255hub # [ 22.661338] tailscaled[615]: wgengine: Reconfig: user dialer2256hub # [ 22.664124] tailscaled[615]: tsdial: bart table size: 42257hub # [ 22.666716] tailscaled[615]: wgengine: Reconfig: configuring DNS2258hub # [ 22.669545] tailscaled[615]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2259hub # [ 22.740126] tailscaled[615]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2260hub # [ 22.742456] tailscaled[615]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2261worker # [ 19.458409] tailscaled[601]: router: enabling connmark-based rp_filter workaround2262worker # [ 19.482866] tailscaled[601]: wgengine: Reconfig: user dialer2263worker # [ 19.484415] tailscaled[601]: tsdial: bart table size: 42264worker # [ 19.485826] tailscaled[601]: wgengine: Reconfig: configuring DNS2265worker # [ 19.487428] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2266hub # [ 22.806657] tailscaled[615]: netmap: suggested exit node: ()2267hub # [ 22.808662] tailscaled[615]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)")2268worker # [ 19.504918] tailscaled[601]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2269worker # [ 19.507781] tailscaled[601]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2270worker # [ 19.551744] systemd[1]: Stopped target Host and Network Name Lookups.2271worker # [ 19.554248] systemd[1]: Stopping Host and Network Name Lookups...2272worker # [ 19.557386] systemd[1]: Stopped target User and Group Name Lookups.2273worker # [ 19.559326] systemd[1]: Stopping User and Group Name Lookups...2274worker # [ 19.561573] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2275worker # [ 19.564723] systemd[1]: nscd.service: Deactivated successfully.2276worker # [ 19.566453] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2277worker # [ 19.577227] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2278worker # [ 19.584111] tailscaled[601]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [14ms] (forced=false)2279worker # [ 19.586577] tailscaled[601]: magicsock: home is now derp-999 ()2280worker # [ 19.588200] tailscaled[601]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::b686:e8f3:e087:c001]:41641 (local)2281worker # [ 19.595150] tailscaled[601]: magicsock: adding connection to derp-999 for home-keep-alive2282worker # [ 19.599092] tailscaled[601]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2283worker # [ 19.601543] tailscaled[601]: derphttp.Client.Connect: connecting to derp-999 ()2284worker # [ 19.614120] tailscaled[601]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2285worker # [ 19.619096] tailscaled[601]: peerapi: serving on http://100.64.0.2:465902286worker # [ 19.620817] tailscaled[601]: peerapi: serving on http://[fd7a:115c:a1e0::2]:471662287worker # [ 19.623363] tailscaled[601]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2288hub # [ 22.933549] tailscaled[615]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2289worker # [ 19.634374] systemd[1]: Started Name Service Cache Daemon (nsncd).2290worker # [ 19.637548] tailscaled[601]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2291worker # [ 19.639933] nsncd[925]: Jul 13 09:24:17.675 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2292worker # [ 19.645314] systemd[1]: Reached target Host and Network Name Lookups.2293worker # [ 19.647288] systemd[1]: Reached target User and Group Name Lookups.2294worker # [ 19.650801] tailscaled[601]: netmap: suggested exit node: ()2295worker # [ 19.652856] tailscaled[601]: writing netmap to disk cache2296worker # [ 19.656087] tailscaled[601]: health(warnable=no-derp-connection): ok2297worker # [ 19.657657] tailscaled[601]: health(warnable=warming-up): ok2298worker # [ 19.659086] tailscaled[601]: health(warnable=no-derp-connection): ok2299worker # [ 19.660646] tailscaled[601]: [RATELIMIT] format("health(warnable=%s): ok")2300worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-toek6U_wW9zc-PQhvLHMouLOHZnCm0R6QiwQKcUQ9NF7DmBxFoiQwFtVHdIUPSmo54as0Iu8i3vsi --hostname tt-worker, in 2.24 seconds)2301worker: waiting for success: tailscale ping hub2302worker # [ 19.670518] tailscaled[601]: magicsock: derp-999 connected; connGen=12303worker # [ 19.696134] tailscaled[601]: localapi: [POST] /localapi/v0/ping2304worker # [ 19.697652] tailscaled[601]: ping(100.64.0.1): sending disco ping to [dxibG] hub ...2305worker # [ 19.699948] tailscaled[601]: magicsock: disco: node [dxibG] d:8877a9d90af272f7 now using 192.168.1.1:41641 mtu=1360 tx=8d522200128c2306worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds)2307hub: must succeed: tailscale ip -42308hub # [ 23.065611] headscale-start[885]: 2026-07-13T09:24:17Z INF http request bytes=0 elapsed=113.923977 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35800 status=2002309hub # [ 23.073080] headscale-start[885]: 2026-07-13T09:24:17Z INF http request bytes=0 elapsed=127.416194 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35832 status=2002310hub: (finished: must succeed: tailscale ip -4, in 0.08 seconds)2311worker: 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.toml2312worker: (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.03 seconds)2313hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub2314hub # [ 23.177253] systemd[1]: Starting tribuchet-hub.socket...2315hub # [ 23.188361] systemd[1]: Listening on tribuchet-hub.socket.2316hub # [ 23.193765] systemd[1]: Starting tribuchet-hub.service...2317hub # [ 23.291339] tribuchet[1086]: 2026-07-13T09:24:18.065475Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[]2318hub # [ 23.296954] tribuchet[1086]: 2026-07-13T09:24:18.074353Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers2319hub # [ 23.302374] tribuchet[1086]: 2026-07-13T09:24:18.079468Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true2320hub # [ 23.311979] tribuchet[1086]: 2026-07-13T09:24:18.089376Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock2321hub # [ 23.316536] systemd[1]: Started tribuchet-hub.service.2322hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.19 seconds)2323worker: must succeed: systemctl start tribuchet-worker2324worker # [ 20.071452] systemd[1]: Starting tribuchet-worker.service...2325worker # [ 20.118790] tailscaled[601]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2326worker # [ 20.128906] tailscaled[601]: netmap: suggested exit node: ()2327worker # [ 20.133322] tailscaled[601]: netmap: suggested exit node: ()2328worker # [ 20.164366] exec[964]: 2026-07-13T09:24:18.201821Z 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 }2329worker # [ 20.176606] exec[964]: 2026-07-13T09:24:18.214292Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service2330worker # [ 20.184139] exec[967]: 2026-07-13T09:24:18.220902Z 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 }2331worker # [ 20.199054] exec[967]: 2026-07-13T09:24:18.236784Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox")2332worker # [ 20.204800] systemd[1]: Started tribuchet-worker.service.2333worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.20 seconds)2334hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"'2335hub # [ 23.553955] tailscaled[615]: magicsock: disco: node [ZBfix] d:833c679720458379 now using [2001:db8:1::2]:41641 mtu=1360 tx=4d79d5172ae52336hub # [ 23.578689] headscale-start[885]: 2026-07-13T09:24:18Z INF http request bytes=0 elapsed=497.348965 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35832 status=2002337hub # [ 23.641121] tribuchet[1086]: 2026-07-13T09:24:18.417484Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }]2338hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 0.13 seconds)2339subtest: a build dispatches over the tailnet2340hub: must succeed: echo tailscale-auth-payload > /root/payload2341worker # [ 20.351446] exec[967]: 2026-07-13T09:24:18.388628Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"]2342hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.02 seconds)2343hub: must succeed: nix-store --add /root/payload2344hub: (finished: must succeed: nix-store --add /root/payload, in 0.16 seconds)2345hub: must succeed: cat > /root/test.nix << 'EOF'2346let2347 bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9";2348 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2349in derivation {2350 name = "tt-tailscale";2351 system = "x86_64-linux";2352 builder = bash + "/bin/bash";2353 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2354}2355EOF2356hub: (finished: must succeed: cat > /root/test.nix << 'EOF'2357let2358 bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9";2359 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2360in derivation {2361 name = "tt-tailscale";2362 system = "x86_64-linux";2363 builder = bash + "/bin/bash";2364 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2365}2366EOF, in 0.04 seconds)2367hub: must succeed: nix-build /root/test.nix --no-out-link2368hub # this derivation will be built:2369hub # /nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv2370hub # building '/nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv'...2371hub # [ 24.213767] tribuchet[1086]: 2026-07-13T09:24:18.991154Z INFO tribuchet::hub::submit: queueing build id="0eab7ec1343399ccead6d5b91a507edd" system="x86_64-linux"2372hub # [ 24.219245] tribuchet[1086]: 2026-07-13T09:24:18.996638Z INFO tribuchet::hub: dispatching build id="0eab7ec1343399ccead6d5b91a507edd" worker="tt-worker"2373hub # tribuchet: building on tt-worker2374worker # [ 20.926439] tailscaled[601]: netmap: suggested exit node: ()2375worker # [ 20.934559] exec[967]: 2026-07-13T09:24:18.972251Z INFO tribuchet::worker: build assigned id="0eab7ec1343399ccead6d5b91a507edd"2376worker # [ 20.955666] systemd[1]: Started Nix Daemon.2377worker # [ 21.010274] nix-daemon[969]: accepted connection from pid 967, user tribuchet (trusted)2378worker # [ 21.017355] exec[967]: 2026-07-13T09:24:19.055131Z 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={}2379worker # [ 21.022993] exec[967]: 2026-07-13T09:24:19.060777Z INFO harmonia_store_remote::client: Nix Version "2.34.8" version="2.34.8"2380hub # [ 24.340440] tribuchet[1086]: 2026-07-13T09:24:19.116690Z INFO tribuchet::hub::relay: input path negotiation done id="0eab7ec1343399ccead6d5b91a507edd" total=8 missing=12381hub # [ 24.359872] systemd[1]: Started Nix Daemon.2382hub # [ 24.503726] nix-daemon[1116]: accepted connection from pid 1086, user root (trusted)2383hub # [ 24.513308] tribuchet[1086]: 2026-07-13T09:24:19.290339Z 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={}2384hub # [ 24.518975] tribuchet[1086]: 2026-07-13T09:24:19.296364Z INFO harmonia_store_remote::client: Nix Version "2.34.8+2" version="2.34.8+2"2385worker # [ 21.250167] systemd[1]: Starting tribuchet-sandboxd.service...2386worker # [ 21.283627] tribuchet-sandboxd[975]: 2026-07-13T09:24:19.320585Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock2387worker # [ 21.293551] systemd[1]: Started tribuchet-sandboxd.service.2388worker # [ 21.298215] tribuchet-sandboxd[975]: 2026-07-13T09:24:19.334774Z INFO tribuchet_sandboxd: leased build="0eab7ec1343399ccead6d5b91a507edd" base=1325400064 uid_count=12389worker # [ 21.303231] exec[967]: 2026-07-13T09:24:19.335369Z INFO tribuchet::worker::build: leased sandbox build_id="0eab7ec1343399ccead6d5b91a507edd" pool_base=1325400064 uid_count=12390worker # [ 21.308894] exec[967]: 2026-07-13T09:24:19.346217Z INFO tribuchet::worker::build: sandbox network decision id="0eab7ec1343399ccead6d5b91a507edd" fixed_output=false network=false net_isolation=false2391worker # [ 21.721397] exec[967]: 2026-07-13T09:24:19.758774Z INFO tribuchet::worker::build: builder finished id="0eab7ec1343399ccead6d5b91a507edd" exit_code=02392worker # [ 21.741302] exec[967]: 2026-07-13T09:24:19.778774Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="0eab7ec1343399ccead6d5b91a507edd"2393worker # [ 21.773591] exec[967]: 2026-07-13T09:24:19.811292Z INFO tribuchet::worker::resume: build result acknowledged id="0eab7ec1343399ccead6d5b91a507edd"2394hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 1.25 seconds)2395hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale2396hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale, in 0.04 seconds)2397hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build'2398hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.04 seconds)2399worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished'2400worker # [ 21.901713] tribuchet-sandboxd[975]: 2026-07-13T09:24:19.938613Z INFO tribuchet_sandboxd: released build="0eab7ec1343399ccead6d5b91a507edd" base=13254000642401worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.05 seconds)2402(finished: subtest: a build dispatches over the tailnet, in 1.59 seconds)2403subtest: a non-tailnet peer is rejected2404worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml2405worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.02 seconds)2406worker: must succeed: systemctl restart tribuchet-worker2407worker # [ 21.961917] exec[967]: 2026-07-13T09:24:19.998388Z INFO tribuchet::worker: handover requested; exiting2408worker # [ 21.965910] systemd[1]: Stopping tribuchet-worker.service...2409hub # [ 25.277786] tribuchet[1086]: 2026-07-13T09:24:20.055136Z INFO tribuchet::hub: worker disconnected worker="tt-worker"2410worker # [ 22.166250] systemd[1]: tribuchet-worker.service: Deactivated successfully.2411worker # [ 22.175372] systemd[1]: Stopped tribuchet-worker.service.2412worker # [ 22.180575] systemd[1]: tribuchet-worker.service: Consumed 79ms CPU time over 2.100s wall clock time, 18.8M memory peak, 14.3M read from disk, 4K written to disk, 4.1K incoming IP traffic, 2.2K outgoing IP traffic.2413worker # [ 22.203727] systemd[1]: Starting tribuchet-worker.service...2414worker # [ 22.251664] exec[999]: 2026-07-13T09:24:20.289205Z 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 }2415worker # [ 22.264587] exec[999]: 2026-07-13T09:24:20.302282Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service2416worker # [ 22.271520] exec[1002]: 2026-07-13T09:24:20.308017Z 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 }2417worker # [ 22.283784] exec[1002]: 2026-07-13T09:24:20.308461Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox")2418worker # [ 22.289311] systemd[1]: Started tribuchet-worker.service.2419worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.34 seconds)2420hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed'2421hub # [ 25.979572] tribuchet[1086]: 2026-07-13T09:24:20.755739Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:586582422worker # [ 22.681465] exec[1002]: 2026-07-13T09:24:20.719020Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2423worker # [ 22.693361] exec[1002]: 2026-07-13T09:24:20.719114Z INFO tribuchet::worker: reconnecting to hub in 1s2424hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.16 seconds)2425(finished: subtest: a non-tailnet peer is rejected, in 1.52 seconds)2426(finished: run the VM test script, in 27.94 seconds)2427test script finished in 28.02s2428cleanup2429kill QemuMachine (pid 47)2430hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14)2431kill QemuMachine (pid 48)2432worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14)2433(finished: cleanup, in 0.34 seconds)2434additionally exposed symbols:2435 hub, worker,2436 vlan1,2437 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