vm-test-run-tribuchet-tailscale
x86_64-linux.nixos-test-tailscale
· build #120
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7start all VMs8hub: starting vm9worker: starting vm10hub: QEMU running (pid 47)11hub # Disk image does not exist, creating the virtualisation disk image...12hub # Formatting '/build/vm-state-hub/tmp.ZbHbVniKwl', 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: 30e3ae72-0269-40f2-9ac9-4e30361a4f7717hub # Superblock backups stored on blocks:18hub # 32768, 98304, 163840, 22937619hub # 20hub # Allocating group tables: 0/8 done21hub # Writing inode tables: 0/8 done22hub # Creating journal (8192 blocks): done23hub # Writing superblocks and filesystem accounting information: 0/8 done24hub # 25hub # Virtualisation disk image created.26hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)27hub # 28hub # 29hub # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1920+7EF31920 CA0030hub # Press Ctrl-B to configure iPXE (PCI 00:03.0)...31hub # 32hub # 33hub # 34hub # 35hub # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1920 7EF31920 CB0036hub # Press Ctrl-B to configure iPXE (PCI 00:09.0)...37hub # 38hub # 39hub # Booting from ROM...40hub # Probing EDD (edd=off to disable)... ok41hub # [ 0.000000] Linux version 6.18.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 202642hub # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5l4rqpz1z88102k8cdlr82im0i0viv2b-nixos-system-hub-test/init regInfo=/nix/store/269g1pc45iwx5f86gcxnvg1gmaw8mv02-closure-info/registration console=ttyS0,115200n8 console=tty043hub # [ 0.000000] BIOS-provided physical RAM map:44hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable45hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved46hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved47hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable48hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved49hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved50hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved51hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved52hub # [ 0.000000] NX (Execute Disable) protection: active53hub # [ 0.000000] APIC: Static calls initialized54hub # [ 0.000000] SMBIOS 2.8 present.55hub # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201456hub # [ 0.000000] DMI: Memory slots populated: 1/157hub # [ 0.000000] Hypervisor detected: KVM58hub # [ 0.000000] last_pfn = 0x7ffdb max_arch_pfn = 0x1000000000059hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0060hub # [ 0.000000] kvm-clock: using sched offset of 518508131 cycles61hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns62hub # [ 0.000005] tsc: Detected 2400.018 MHz processor63hub # [ 0.000812] last_pfn = 0x7ffdb max_arch_pfn = 0x1000000000064hub # [ 0.000848] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs65hub # [ 0.000851] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT66hub # [ 0.002753] found SMP MP-table at [mem 0x000f5470-0x000f547f]67hub # [ 0.002763] Using GB pages for direct mapping68hub # [ 0.002842] RAMDISK: [mem 0x7e302000-0x7ffcffff]69hub # [ 0.002851] ACPI: Early table checksum verification disabled70hub # [ 0.002854] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )71hub # [ 0.002858] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)72hub # [ 0.002862] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)73hub # [ 0.002869] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)74hub # [ 0.002871] ACPI: FACS 0x000000007FFE0000 00004075hub # [ 0.002873] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)76hub # [ 0.002875] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)77hub # [ 0.002876] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)78hub # [ 0.002877] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]79hub # [ 0.002879] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]80hub # [ 0.002879] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]81hub # [ 0.002880] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]82hub # [ 0.002880] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]83hub # [ 0.002881] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]84hub # [ 0.003359] No NUMA configuration found85hub # [ 0.003360] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff]86hub # [ 0.003364] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff]87hub # [ 0.005905] Zone ranges:88hub # [ 0.005906] DMA [mem 0x0000000000001000-0x0000000000ffffff]89hub # [ 0.005908] DMA32 [mem 0x0000000001000000-0x000000007ffdafff]90hub # [ 0.005909] Normal empty91hub # [ 0.005910] Device empty92hub # [ 0.005910] Movable zone start for each node93hub # [ 0.005911] Early memory node ranges94hub # [ 0.005912] node 0: [mem 0x0000000000001000-0x000000000009efff]95hub # [ 0.005913] node 0: [mem 0x0000000000100000-0x000000007ffdafff]96hub # [ 0.005914] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff]97hub # [ 0.005935] On node 0, zone DMA: 1 pages in unavailable ranges98hub # [ 0.006225] On node 0, zone DMA: 97 pages in unavailable ranges99hub # [ 0.045828] On node 0, zone DMA32: 37 pages in unavailable ranges100hub # [ 0.046812] ACPI: PM-Timer IO Port: 0x608101hub # [ 0.046829] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])102hub # [ 0.046862] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23103hub # [ 0.046865] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)104hub # [ 0.046867] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)105hub # [ 0.046868] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)106hub # [ 0.046869] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)107hub # [ 0.046870] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)108hub # [ 0.046872] ACPI: Using ACPI (MADT) for SMP configuration information109hub # [ 0.046873] ACPI: HPET id: 0x8086a201 base: 0xfed00000110hub # [ 0.046879] TSC deadline timer available111hub # [ 0.046883] CPU topo: Max. logical packages: 1112hub # [ 0.046884] CPU topo: Max. logical dies: 1113hub # [ 0.046884] CPU topo: Max. dies per package: 1114hub # [ 0.046888] CPU topo: Max. threads per core: 1115hub # [ 0.046888] CPU topo: Num. cores per package: 1116hub # [ 0.046889] CPU topo: Num. threads per package: 1117hub # [ 0.046889] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs118hub # [ 0.046912] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()119hub # [ 0.046951] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]120hub # [ 0.046953] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]121hub # [ 0.046954] [mem 0x80000000-0xfeffbfff] available for PCI devices122hub # [ 0.046956] Booting paravirtualized kernel on KVM123hub # [ 0.046959] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns124hub # [ 0.051432] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1125hub # [ 0.054232] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152126hub # [ 0.054284] kvm-guest: PV spinlocks disabled, single CPU127hub # [ 0.054286] 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/5l4rqpz1z88102k8cdlr82im0i0viv2b-nixos-system-hub-test/init regInfo=/nix/store/269g1pc45iwx5f86gcxnvg1gmaw8mv02-closure-info/registration console=ttyS0,115200n8 console=tty0128hub # [ 0.054384] Unknown kernel command line parameters "regInfo=/nix/store/269g1pc45iwx5f86gcxnvg1gmaw8mv02-closure-info/registration", will be passed to user space.129hub # [ 0.054397] random: crng init done130hub # [ 0.054397] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes131hub # [ 0.056775] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)132hub # [ 0.056813] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)133hub # [ 0.056851] Fallback order for Node 0: 0134hub # [ 0.056854] Built 1 zonelists, mobility grouping on. Total pages: 524153135hub # [ 0.056856] Policy zone: DMA32136hub # [ 0.059584] mem auto-init: stack:all(zero), heap alloc:on, heap free:off137hub # [ 0.063671] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1138hub # [ 0.068900] allocated 4194304 bytes of page_ext139hub # [ 0.078944] ftrace: allocating 48598 entries in 192 pages140hub # [ 0.078946] ftrace: allocated 192 pages with 2 groups141hub # [ 0.079877] Dynamic Preempt: lazy142hub # [ 0.080019] rcu: Preemptible hierarchical RCU implementation.143hub # [ 0.080020] rcu: RCU event tracing is enabled.144hub # [ 0.080020] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.145hub # [ 0.080022] Trampoline variant of Tasks RCU enabled.146hub # [ 0.080022] Rude variant of Tasks RCU enabled.147hub # [ 0.080023] Tracing variant of Tasks RCU enabled.148hub # [ 0.080023] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.149hub # [ 0.080024] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1150hub # [ 0.080048] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.151hub # [ 0.080050] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.152hub # [ 0.080051] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.153hub # [ 0.084548] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16154hub # [ 0.084840] rcu: srcu_init: Setting srcu_struct sizes based on contention.155hub # [ 0.084960] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)156hub # [ 0.092105] Console: colour VGA+ 80x25157hub # [ 0.092109] printk: legacy console [tty0] enabled158hub # [ 0.132408] printk: legacy console [ttyS0] enabled159hub # [ 0.318573] ACPI: Core revision 20250807160hub # [ 0.320147] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns161hub # [ 0.323044] APIC: Switch to symmetric I/O mode setup162hub # [ 0.324872] x2apic enabled163hub # [ 0.326133] APIC: Switched APIC routing to: physical x2apic164hub # [ 0.329092] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1165hub # [ 0.330896] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns166hub # [ 0.333909] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018)167hub # [ 0.336027] x86/cpu: User Mode Instruction Prevention (UMIP) activated168hub # [ 0.337068] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127169hub # [ 0.337908] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0170hub # [ 0.338912] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto171hub # [ 0.339908] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl172hub # [ 0.340908] Transient Scheduler Attacks: Mitigation: Clear CPU buffers173hub # [ 0.342907] Spectre V2 : Mitigation: Enhanced / Automatic IBRS174hub # [ 0.344907] Speculative Return Stack Overflow: Mitigation: Safe RET175hub # [ 0.345907] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization176hub # [ 0.346915] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier177hub # [ 0.348908] active return thunk: srso_alias_return_thunk178hub # [ 0.349937] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'179hub # [ 0.351907] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'180hub # [ 0.352907] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'181hub # [ 0.354907] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'182hub # [ 0.356907] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'183hub # [ 0.357907] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'184hub # [ 0.358907] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'185hub # [ 0.359907] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'186hub # [ 0.361907] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'187hub # [ 0.363907] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256188hub # [ 0.364907] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64189hub # [ 0.365907] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512190hub # [ 0.367907] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024191hub # [ 0.369907] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8192hub # [ 0.370907] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16193hub # [ 0.371908] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24194hub # [ 0.373907] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.195hub # [ 0.409164] Freeing SMP alternatives memory: 44K196hub # [ 0.409911] pid_max: default: 32768 minimum: 301197hub # [ 0.411012] LSM: initializing lsm=capability,landlock,yama,bpf,ima198hub # [ 0.413033] landlock: Up and running.199hub # [ 0.413907] Yama: becoming mindful.200hub # [ 0.415140] LSM support for eBPF active201hub # [ 0.416026] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)202hub # [ 0.417960] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)203hub # [ 0.420375] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)204hub # [ 0.421478] Performance Events: Fam17h+ core perfctr, AMD PMU driver.205hub # [ 0.421912] ... version: 2206hub # [ 0.422909] ... bit width: 48207hub # [ 0.423964] ... generic counters: 6208hub # [ 0.424909] ... generic bitmap: 000000000000003f209hub # [ 0.425909] ... fixed-purpose counters: 0210hub # [ 0.426909] ... fixed-purpose bitmap: 0000000000000000211hub # [ 0.427909] ... value mask: 0000ffffffffffff212hub # [ 0.428909] ... max period: 00007fffffffffff213hub # [ 0.429909] ... global_ctrl mask: 000000000000003f214hub # [ 0.431031] signal: max sigframe size: 3376215hub # [ 0.432012] rcu: Hierarchical SRCU implementation.216hub # [ 0.432913] rcu: Max phase no-delay instances is 400.217hub # [ 0.438537] smp: Bringing up secondary CPUs ...218hub # [ 0.438924] smp: Brought up 1 node, 1 CPU219hub # [ 0.439912] smpboot: Total of 1 processors activated (4800.03 BogoMIPS)220hub # [ 0.441100] Memory: 1969272K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved)221hub # [ 0.442205] devtmpfs: initialized222hub # [ 0.443210] x86/mm: Memory block size: 128MB223hub # [ 0.445111] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns224hub # [ 0.445942] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)225hub # [ 0.446941] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).226hub # [ 0.447996] pinctrl core: initialized pinctrl subsystem227hub # [ 0.449242] PM: RTC time: 09:51:22, date: 2026-07-13228hub # [ 0.452958] NET: Registered PF_NETLINK/PF_ROUTE protocol family229hub # [ 0.454471] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations230hub # [ 0.454940] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations231hub # [ 0.456237] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations232hub # [ 0.456922] audit: initializing netlink subsys (disabled)233hub # [ 0.458236] thermal_sys: Registered thermal governor 'fair_share'234hub # [ 0.458238] thermal_sys: Registered thermal governor 'bang_bang'235hub # [ 0.458913] audit: type=2000 audit(1783936282.156:1): state=initialized audit_enabled=0 res=1236hub # [ 0.460912] thermal_sys: Registered thermal governor 'step_wise'237hub # [ 0.460913] thermal_sys: Registered thermal governor 'user_space'238hub # [ 0.461910] thermal_sys: Registered thermal governor 'power_allocator'239hub # [ 0.462934] cpuidle: using governor menu240hub # [ 0.466080] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5241hub # [ 0.467224] PCI: Using configuration type 1 for base access242hub # [ 0.467909] PCI: Using configuration type 1 for extended access243hub # [ 0.469144] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.244hub # [ 0.475926] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages245hub # [ 0.476910] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page246hub # [ 0.481909] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages247hub # [ 0.482910] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page248hub # [ 0.494223] ACPI: Added _OSI(Module Device)249hub # [ 0.494910] ACPI: Added _OSI(Processor Device)250hub # [ 0.496777] ACPI: Added _OSI(Processor Aggregator Device)251hub # [ 0.501757] ACPI: 1 ACPI AML tables successfully acquired and loaded252hub # [ 0.508369] ACPI: Interpreter enabled253hub # [ 0.508928] ACPI: PM: (supports S0 S3 S4 S5)254hub # [ 0.509911] ACPI: Using IOAPIC for interrupt routing255hub # [ 0.510930] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug256hub # [ 0.513908] PCI: Using E820 reservations for host bridge windows257hub # [ 0.515061] ACPI: Enabled 2 GPEs in block 00 to 0F258hub # [ 0.523385] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])259hub # [ 0.523917] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]260hub # [ 0.525268] acpiphp: Slot [3] registered261hub # [ 0.525955] acpiphp: Slot [4] registered262hub # [ 0.526966] acpiphp: Slot [5] registered263hub # [ 0.527957] acpiphp: Slot [6] registered264hub # [ 0.528998] acpiphp: Slot [7] registered265hub # [ 0.529951] acpiphp: Slot [8] registered266hub # [ 0.530967] acpiphp: Slot [9] registered267hub # [ 0.531951] acpiphp: Slot [10] registered268hub # [ 0.532952] acpiphp: Slot [11] registered269hub # [ 0.533964] acpiphp: Slot [12] registered270hub # [ 0.534952] acpiphp: Slot [13] registered271hub # [ 0.535941] acpiphp: Slot [14] registered272hub # [ 0.536942] acpiphp: Slot [15] registered273hub # [ 0.537956] acpiphp: Slot [16] registered274hub # [ 0.538942] acpiphp: Slot [17] registered275hub # [ 0.539961] acpiphp: Slot [18] registered276hub # [ 0.540941] acpiphp: Slot [19] registered277hub # [ 0.541973] acpiphp: Slot [20] registered278hub # [ 0.542943] acpiphp: Slot [21] registered279hub # [ 0.543942] acpiphp: Slot [22] registered280hub # [ 0.544942] acpiphp: Slot [23] registered281hub # [ 0.545957] acpiphp: Slot [24] registered282hub # [ 0.546944] acpiphp: Slot [25] registered283hub # [ 0.547942] acpiphp: Slot [26] registered284hub # [ 0.548958] acpiphp: Slot [27] registered285hub # [ 0.549951] acpiphp: Slot [28] registered286hub # [ 0.550975] acpiphp: Slot [29] registered287hub # [ 0.551943] acpiphp: Slot [30] registered288hub # [ 0.552976] acpiphp: Slot [31] registered289hub # [ 0.553933] PCI host bridge to bus 0000:00290hub # [ 0.554916] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]291hub # [ 0.555910] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]292hub # [ 0.556911] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]293hub # [ 0.557910] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]294hub # [ 0.558910] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]295hub # [ 0.559910] pci_bus 0000:00: root bus resource [bus 00-ff]296hub # [ 0.561305] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint297hub # [ 0.562821] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint298hub # [ 0.564820] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint299hub # [ 0.567735] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]300hub # [ 0.569002] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk301hub # [ 0.569910] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk302hub # [ 0.570910] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk303hub # [ 0.571910] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk304hub # [ 0.573405] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint305hub # [ 0.574974] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]306hub # [ 0.577230] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint307hub # [ 0.578534] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI308hub # [ 0.579923] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB309hub # [ 0.581372] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint310hub # [ 0.584004] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]311hub # [ 0.584939] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]312hub # [ 0.585961] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]313hub # [ 0.587150] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]314hub # [ 0.589072] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint315hub # [ 0.591945] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]316hub # [ 0.592924] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]317hub # [ 0.593961] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]318hub # [ 0.594924] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]319hub # [ 0.598096] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint320hub # [ 0.600953] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]321hub # [ 0.601924] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]322hub # [ 0.602961] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]323hub # [ 0.605923] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint324hub # [ 0.608772] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]325hub # [ 0.609923] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]326hub # [ 0.610961] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]327hub # [ 0.613896] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint328hub # [ 0.616924] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]329hub # [ 0.618926] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]330hub # [ 0.619961] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]331hub # [ 0.623060] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint332hub # [ 0.625946] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]333hub # [ 0.626923] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]334hub # [ 0.627961] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]335hub # [ 0.631238] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint336hub # [ 0.633942] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]337hub # [ 0.634924] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]338hub # [ 0.635961] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]339hub # [ 0.639085] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint340hub # [ 0.641895] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]341hub # [ 0.642924] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]342hub # [ 0.643961] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]343hub # [ 0.644924] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]344hub # [ 0.647949] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint345hub # [ 0.649936] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]346hub # [ 0.650961] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]347hub # [ 0.653923] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint348hub # [ 0.656910] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]349hub # [ 0.657924] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]350hub # [ 0.658961] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]351hub # [ 0.661923] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint352hub # [ 0.664937] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]353hub # [ 0.665925] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]354hub # [ 0.666961] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]355hub # [ 0.675271] ACPI: PCI: Interrupt link LNKA configured for IRQ 10356hub # [ 0.676116] ACPI: PCI: Interrupt link LNKB configured for IRQ 10357hub # [ 0.677109] ACPI: PCI: Interrupt link LNKC configured for IRQ 11358hub # [ 0.678115] ACPI: PCI: Interrupt link LNKD configured for IRQ 11359hub # [ 0.679017] ACPI: PCI: Interrupt link LNKS configured for IRQ 9360hub # [ 0.681190] iommu: Default domain type: Translated361hub # [ 0.681919] iommu: DMA domain TLB invalidation policy: lazy mode362hub # [ 0.683201] ACPI: bus type USB registered363hub # [ 0.683962] usbcore: registered new interface driver usbfs364hub # [ 0.684939] usbcore: registered new interface driver hub365hub # [ 0.685920] usbcore: registered new device driver usb366hub # [ 0.687927] NetLabel: Initializing367hub # [ 0.688909] NetLabel: domain hash size = 128368hub # [ 0.689909] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO369hub # [ 0.690952] NetLabel: unlabeled traffic allowed by default370hub # [ 0.691925] PCI: Using ACPI for IRQ routing371hub # [ 0.693559] pci 0000:00:02.0: vgaarb: setting as boot VGA device372hub # [ 0.693904] pci 0000:00:02.0: vgaarb: bridge control possible373hub # [ 0.693904] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none374hub # [ 0.693911] vgaarb: loaded375hub # [ 0.695038] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0376hub # [ 0.695909] hpet0: 3 comparators, 64-bit 100.000000 MHz counter377hub # [ 0.700996] clocksource: Switched to clocksource kvm-clock378hub # [ 0.705210] VFS: Disk quotas dquot_6.6.0379hub # [ 0.706456] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)380hub # [ 0.708689] pnp: PnP ACPI init381hub # [ 0.710375] pnp: PnP ACPI: found 6 devices382hub # [ 0.718653] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns383hub # [ 0.721198] clocksource: Switched to clocksource acpi_pm384hub # [ 0.722910] NET: Registered PF_INET protocol family385hub # [ 0.725246] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)386hub # [ 0.743964] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)387hub # [ 0.746747] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)388hub # [ 0.749205] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)389hub # [ 0.751646] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)390hub # [ 0.753932] TCP: Hash tables configured (established 16384 bind 16384)391hub # [ 0.756218] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)392hub # [ 0.758484] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)393hub # [ 0.760521] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)394hub # [ 0.762731] NET: Registered PF_UNIX/PF_LOCAL protocol family395hub # [ 0.764483] NET: Registered PF_XDP protocol family396hub # [ 0.766036] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]397hub # [ 0.767992] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]398hub # [ 0.770046] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]399hub # [ 0.772185] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]400hub # [ 0.774276] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]401hub # [ 0.776671] pci 0000:00:01.0: PIIX3: Enabling Passive Release402hub # [ 0.778647] pci 0000:00:00.0: Limiting direct PCI/PCI transfers403hub # [ 0.782503] ACPI: \_SB_.LNKD: Enabled at IRQ 11404hub # [ 0.786026] PCI: CLS 0 bytes, default 64405hub # [ 0.787602] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns406hub # [ 0.790568] Trying to unpack rootfs image as initramfs...407hub # [ 0.839567] Initialise system trusted keyrings408hub # [ 0.844214] workingset: timestamp_bits=40 max_order=19 bucket_order=0409hub # [ 0.869422] Key type asymmetric registered410hub # [ 0.870759] Asymmetric key parser 'x509' registered411hub # [ 0.874175] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)412hub # [ 0.880182] io scheduler mq-deadline registered413hub # [ 0.883115] io scheduler kyber registered414hub # [ 0.886723] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled415hub # [ 0.888930] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A416hub # [ 0.898016] Linux agpgart interface v0.103417hub # [ 0.901168] ACPI: bus type drm_connector registered418hub # [ 0.905264] usbcore: registered new interface driver usbserial_generic419hub # [ 0.907156] usbserial: USB Serial support registered for generic420hub # [ 0.911129] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.421hub # [ 0.911129] Please enable it if your BIOS has the CPPC option.422hub # [ 0.915022] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled423hub # [ 0.923267] drop_monitor: Initializing network drop monitor service424hub # [ 0.925227] NET: Registered PF_INET6 protocol family425hub # [ 0.931685] Segment Routing with IPv6426hub # [ 0.936136] In-situ OAM (IOAM) with IPv6427hub # [ 0.937766] IPI shorthand broadcast: enabled428hub # [ 0.946508] sched_clock: Marking stable (703038818, 243054972)->(1139641942, -193548152)429hub # [ 0.953270] registered taskstats version 1430hub # [ 0.954842] Loading compiled-in X.509 certificates431hub # [ 0.976737] Demotion targets for Node 0: null432hub # [ 0.980172] Key type .fscrypt registered433hub # [ 0.983124] Key type fscrypt-provisioning registered434hub # [ 0.984769] ima: No TPM chip found, activating TPM-bypass!435hub # [ 0.990115] ima: Allocated hash algorithm: sha1436hub # [ 0.991538] ima: No architecture policies found437hub # [ 0.996308] PM: Magic number: 2:276:879438hub # [ 1.000559] RAS: Correctable Errors collector initialized.439hub # [ 1.010012] clk: Disabling unused clocks440hub # [ 1.013120] PM: genpd: Disabling unused power domains441hub # [ 1.167665] Freeing initrd memory: 29496K442hub # [ 1.171698] Freeing unused decrypted memory: 2028K443hub # [ 1.175224] Freeing unused kernel image (initmem) memory: 3636K444hub # [ 1.177133] Write protecting the kernel read-only data: 32768k445hub # [ 1.179967] Freeing unused kernel image (text/rodata gap) memory: 1272K446hub # [ 1.182489] Freeing unused kernel image (rodata/data gap) memory: 796K447hub # [ 1.235630] x86/mm: Checked W+X mappings: passed, no W+X pages found.448hub # [ 1.237551] Run /init as init process449hub # [ 1.249297] systemd[1]: Inserted module 'autofs4'450hub # [ 1.266541] fuse: init (API version 7.45)451hub # [ 1.273992] ACPI: \_SB_.LNKC: Enabled at IRQ 10452hub # [ 1.282807] ACPI: \_SB_.LNKA: Enabled at IRQ 10453hub # [ 1.287412] ACPI: \_SB_.LNKB: Enabled at IRQ 11454hub # [ 1.328155] systemd[1]: Successfully made /usr/ read-only.455hub # [ 1.667657] 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.689397] systemd[1]: Detected virtualization kvm.457hub # [ 1.693357] systemd[1]: Detected architecture x86-64.458hub # [ 1.697303] systemd[1]: Running in initrd.459hub # [ 1.701565] systemd[1]: Initializing machine ID from random generator.460hub # [ 1.706606] systemd[1]: Hostname set to <hub>.461hub # [ 1.928510] systemd[1]: bpf-restrict-fs: LSM BPF program attached462hub # [ 1.988471] systemd[1]: Queued start job for default target Initrd Default Target.463hub # [ 1.993763] systemd[1]: Created slice Slice /system/modprobe.464hub # [ 1.995846] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.465hub # [ 1.998349] systemd[1]: Expecting device /dev/disk/by-label/nixos...466hub # [ 2.000312] systemd[1]: Reached target Path Units.467hub # [ 2.001861] systemd[1]: Reached target Slice Units.468hub # [ 2.003463] systemd[1]: Reached target Swaps.469hub # [ 2.004894] systemd[1]: Reached target Timer Units.470hub # [ 2.006618] systemd[1]: Listening on D-Bus System Message Bus Socket.471hub # [ 2.008714] systemd[1]: Listening on Journal Socket (/dev/log).472hub # [ 2.010710] systemd[1]: Listening on Journal Sockets.473hub # [ 2.012461] systemd[1]: Listening on udev Control Socket.474hub # [ 2.014252] systemd[1]: Listening on udev Kernel Socket.475hub # [ 2.015947] systemd[1]: Reached target Socket Units.476hub # [ 2.018710] systemd[1]: Starting Create List of Static Device Nodes...477hub # [ 2.024729] systemd[1]: Starting Load Kernel Module 9pnet_virtio...478hub # [ 2.036886] systemd[1]: Starting Load Kernel Module configfs...479hub # [ 2.049304] systemd[1]: Starting Journal Service...480hub # [ 2.067191] systemd[1]: Starting Load Kernel Modules...481hub # [ 2.075044] netfs: FS-Cache loaded482hub # [ 2.076725] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os483hub # [ 2.095661] 9pnet: Installing 9P2000 support484hub # [ 2.113571] systemd[1]: Starting Coldplug All udev Devices...485hub # [ 2.118388] systemd-journald[67]: Collecting audit messages is disabled.486hub # [ 2.133275] systemd[1]: Finished Create List of Static Device Nodes.487hub # [ 2.142841] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.488hub # [ 2.155181] systemd[1]: Finished Load Kernel Module 9pnet_virtio.489hub # [ 2.163628] systemd[1]: modprobe@configfs.service: Deactivated successfully.490hub # [ 2.168744] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.491hub # [ 2.176747] systemd[1]: Finished Load Kernel Module configfs.492hub # [ 2.182262] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev493hub # [ 2.186881] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config494hub # [ 2.204188] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...495hub # [ 2.227601] systemd[1]: Finished Load Kernel Modules.496hub # [ 2.240210] systemd[1]: Starting Apply Kernel Variables...497hub # [ 2.256756] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.498hub # [ 2.272457] systemd[1]: Starting Create Static Device Nodes in /dev...499hub # [ 2.291237] systemd[1]: Finished Apply Kernel Variables.500hub # [ 2.309981] systemd[1]: Finished Create Static Device Nodes in /dev.501hub # [ 2.316561] systemd[1]: Reached target Preparation for Local File Systems.502hub # [ 2.323209] systemd[1]: Reached target Local File Systems.503hub # [ 2.085308] systemd-modules-load[68]: Inserted module 'dm_mod'504hub # [ 2.089483] systemd-modules-load[68]: Inserted module 'virtio_balloon'505hub # [ 2.091437] systemd-modules-load[68]: Inserted module 'virtio_gpu'506hub # [ 2.336352] systemd[1]: Starting Rule-based Manager for Device Events and Files...507hub # [ 2.346389] systemd[1]: Started Journal Service.508hub # [ 2.128730] systemd[1]: Starting Create System Files and Directories...509hub # [ 2.161306] systemd-udevd[75]: Using default interface naming scheme 'v261'.510hub # [ 2.163331] systemd[1]: Finished Create System Files and Directories.511hub # [ 2.201114] systemd[1]: Started Rule-based Manager for Device Events and Files.512hub # [ 2.253123] systemd[1]: Finished Coldplug All udev Devices.513hub # [ 2.256384] systemd[1]: Reached target System Initialization.514hub # [ 2.258235] systemd[1]: Reached target Basic System.515worker: QEMU running (pid 48)516worker # Disk image does not exist, creating the virtualisation disk image...517worker # Formatting '/build/vm-state-worker/tmp.BhrBm9PPwh', 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 inodes521worker # Filesystem UUID: 0e430e08-18d4-417f-b7e2-f6ddb956521c522worker # Superblock backups stored on blocks:523worker # 32768, 98304, 163840, 229376524worker # 525worker # Allocating group tables: 0/8 done526worker # Writing inode tables: 0/8 done527worker # Creating journal (8192 blocks): done528worker # Writing superblocks and filesystem accounting information: 0/8 done529(finished: start all VMs, in 3.45 seconds)530worker # 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.791383] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12550worker # Booting from ROM...551worker # Probing EDD (edd=off to disable)... ok552hub # [ 2.825326] serio: i8042 KBD port at 0x60,0x64 irq 1553hub # [ 2.831265] uhci_hcd 0000:00:01.2: UHCI Host Controller554hub # [ 2.832504] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1555hub # [ 2.856516] serio: i8042 AUX port at 0x60,0x64 irq 12556hub # [ 2.865125] uhci_hcd 0000:00:01.2: detected 2 ports557hub # [ 2.866487] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100558hub # [ 2.871495] SCSI subsystem initialized559hub # [ 2.874292] virtio_blk virtio5: 1/0/0 default/read/poll queues560hub # [ 2.892617] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18561hub # [ 2.895342] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)562hub # [ 2.911276] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1563hub # [ 2.932100] usb usb1: Product: UHCI Host Controller564hub # [ 2.690849] systemd[1]: Starting Virtual Console Setup...565hub # [ 2.696365] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.566hub # [ 2.949674] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd567hub # [ 2.957733] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0568hub # [ 2.723101] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.569hub # [ 2.726777] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.570hub # [ 2.744135] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.571hub # [ 2.990819] usb usb1: SerialNumber: 0000:00:01.2572hub # [ 2.749150] systemd[1]: Finished Virtual Console Setup.573hub # [ 3.003162] hub 1-0:1.0: USB hub found574hub # [ 3.010252] hub 1-0:1.0: 2 ports detected575hub # [ 2.798323] systemd[1]: Found device /dev/disk/by-label/nixos.576hub # [ 2.800213] systemd[1]: Reached target Initrd Root Device.577hub # [ 2.806111] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...578hub # [ 3.061142] scsi host0: ata_piix579hub # [ 3.066030] scsi host1: ata_piix580hub # [ 3.068910] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0581hub # [ 3.073301] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0582hub # [ 2.840695] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks583hub # [ 2.847478] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.584hub # [ 2.885448] systemd[1]: Mounting /sysroot...585worker # [ 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 2026586worker # [ 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/5yvayla79h0dwkrrlvkr19gvb00m07fh-nixos-system-worker-test/init regInfo=/nix/store/wakpnaizsh62df3f37xm0qcc44n34qyj-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] reserved591worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable592worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved593worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved594worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved595worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved596worker # [ 0.000000] NX (Execute Disable) protection: active597worker # [ 0.000000] APIC: Static calls initialized598worker # [ 0.000000] SMBIOS 2.8 present.599worker # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014600worker # [ 0.000000] DMI: Memory slots populated: 1/1601worker # [ 0.000000] Hypervisor detected: KVM602worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000603worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00604worker # [ 0.000001] kvm-clock: using sched offset of 507289535 cycles605worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns606worker # [ 0.000006] tsc: Detected 2400.018 MHz processor607worker # [ 0.000812] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000608worker # [ 0.000848] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs609worker # [ 0.000851] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT610worker # [ 0.002751] found SMP MP-table at [mem 0x000f5470-0x000f547f]611worker # [ 0.002762] Using GB pages for direct mapping612worker # [ 0.002882] RAMDISK: [mem 0x7e2fa000-0x7ffcffff]613worker # [ 0.002891] ACPI: Early table checksum verification disabled614worker # [ 0.002894] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )615worker # [ 0.002898] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)616worker # [ 0.002901] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)617worker # [ 0.002908] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001)618worker # [ 0.002910] ACPI: FACS 0x000000007FFE0000 000040619worker # [ 0.002912] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)620worker # [ 0.002913] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)621hub # [ 3.232646] ata2: found unknown device (class 0)622worker # [ 0.002915] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)623worker # [ 0.002916] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3]624worker # [ 0.002917] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f]625worker # [ 0.002918] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]626hub # [ 3.238203] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100627worker # [ 0.002919] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b]628worker # [ 0.002919] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3]629hub # [ 3.241531] usb 1-1: new full-speed USB device number 2 using uhci_hcd630worker # [ 0.002919] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb]631worker # [ 0.003392] No NUMA configuration found632worker # [ 0.003393] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]633worker # [ 0.003396] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]634worker # [ 0.005788] Zone ranges:635worker # [ 0.005789] DMA [mem 0x0000000000001000-0x0000000000ffffff]636worker # [ 0.005791] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff]637worker # [ 0.005792] Normal empty638worker # [ 0.005793] Device empty639worker # [ 0.005794] Movable zone start for each node640worker # [ 0.005795] Early memory node ranges641hub # [ 3.251742] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5642worker # [ 0.005795] node 0: [mem 0x0000000000001000-0x000000000009efff]643worker # [ 0.005796] node 0: [mem 0x0000000000100000-0x000000007ffd7fff]644worker # [ 0.005797] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]645worker # [ 0.005828] On node 0, zone DMA: 1 pages in unavailable ranges646worker # [ 0.006104] On node 0, zone DMA: 97 pages in unavailable ranges647worker # [ 0.043080] On node 0, zone DMA32: 40 pages in unavailable ranges648worker # [ 0.044071] ACPI: PM-Timer IO Port: 0x608649worker # [ 0.044087] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])650worker # [ 0.044123] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23651worker # [ 0.044126] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)652worker # [ 0.044128] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)653worker # [ 0.044129] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)654worker # [ 0.044131] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)655worker # [ 0.044131] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)656worker # [ 0.044134] ACPI: Using ACPI (MADT) for SMP configuration information657worker # [ 0.044135] ACPI: HPET id: 0x8086a201 base: 0xfed00000658worker # [ 0.044139] TSC deadline timer available659worker # [ 0.044143] CPU topo: Max. logical packages: 1660worker # [ 0.044144] CPU topo: Max. logical dies: 1661worker # [ 0.044144] CPU topo: Max. dies per package: 1662worker # [ 0.044148] CPU topo: Max. threads per core: 1663worker # [ 0.044148] CPU topo: Num. cores per package: 1664worker # [ 0.044149] CPU topo: Num. threads per package: 1665worker # [ 0.044149] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs666worker # [ 0.044171] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()667worker # [ 0.044209] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]668worker # [ 0.044210] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]669worker # [ 0.044212] [mem 0x80000000-0xfeffbfff] available for PCI devices670worker # [ 0.044213] Booting paravirtualized kernel on KVM671worker # [ 0.044216] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns672worker # [ 0.048669] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1673worker # [ 0.050917] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152674worker # [ 0.050966] kvm-guest: PV spinlocks disabled, single CPU675worker # [ 0.050967] 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/5yvayla79h0dwkrrlvkr19gvb00m07fh-nixos-system-worker-test/init regInfo=/nix/store/wakpnaizsh62df3f37xm0qcc44n34qyj-closure-info/registration console=ttyS0,115200n8 console=tty0676worker # [ 0.051063] Unknown kernel command line parameters "regInfo=/nix/store/wakpnaizsh62df3f37xm0qcc44n34qyj-closure-info/registration", will be passed to user space.677worker # [ 0.051076] random: crng init done678worker # [ 0.051076] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes679worker # [ 0.053303] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)680worker # [ 0.053325] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)681worker # [ 0.053359] Fallback order for Node 0: 0682worker # [ 0.053362] Built 1 zonelists, mobility grouping on. Total pages: 524150683worker # [ 0.053363] Policy zone: DMA32684worker # [ 0.056112] mem auto-init: stack:all(zero), heap alloc:on, heap free:off685worker # [ 0.059834] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1686worker # [ 0.064422] allocated 4194304 bytes of page_ext687worker # [ 0.074387] ftrace: allocating 48598 entries in 192 pages688worker # [ 0.074389] ftrace: allocated 192 pages with 2 groups689worker # [ 0.075284] Dynamic Preempt: lazy690hub # [ 3.330022] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray691worker # [ 0.075409] rcu: Preemptible hierarchical RCU implementation.692worker # [ 0.075410] rcu: RCU event tracing is enabled.693worker # [ 0.075411] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.694worker # [ 0.075413] Trampoline variant of Tasks RCU enabled.695worker # [ 0.075413] Rude variant of Tasks RCU enabled.696worker # [ 0.075413] Tracing variant of Tasks RCU enabled.697worker # [ 0.075414] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.698worker # [ 0.075415] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1699worker # [ 0.075430] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.700worker # [ 0.075432] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.701worker # [ 0.075432] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.702worker # [ 0.080171] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16703worker # [ 0.080448] rcu: srcu_init: Setting srcu_struct sizes based on contention.704worker # [ 0.080557] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)705hub # [ 3.351537] cdrom: Uniform CD-ROM driver Revision: 3.20706worker # [ 0.087718] Console: colour VGA+ 80x25707worker # [ 0.087723] printk: legacy console [tty0] enabled708worker # [ 0.128269] printk: legacy console [ttyS0] enabled709worker # [ 0.311430] ACPI: Core revision 20250807710worker # [ 0.312962] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns711worker # [ 0.315689] APIC: Switch to symmetric I/O mode setup712worker # [ 0.317399] x2apic enabled713worker # [ 0.318622] APIC: Switched APIC routing to: physical x2apic714worker # [ 0.321433] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1715worker # [ 0.323232] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns716worker # [ 0.326280] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018)717worker # [ 0.328399] x86/cpu: User Mode Instruction Prevention (UMIP) activated718hub # [ 3.373326] EXT4-fs (vda): mounted filesystem 30e3ae72-0269-40f2-9ac9-4e30361a4f77 r/w with ordered data mode. Quota mode: none.719worker # [ 0.329431] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127720worker # [ 0.330279] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0721hub # [ 3.137254] systemd[1]: Mounted /sysroot.722worker # [ 0.331283] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto723worker # [ 0.333279] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl724hub # [ 3.140548] systemd[1]: Reached target Initrd Root File System.725worker # [ 0.334279] Transient Scheduler Attacks: Mitigation: Clear CPU buffers726worker # [ 0.335278] Spectre V2 : Mitigation: Enhanced / Automatic IBRS727hub # [ 3.144896] systemd[1]: Mounting /sysroot/nix/.ro-store...728worker # [ 0.336278] Speculative Return Stack Overflow: Mitigation: Safe RET729worker # [ 0.337278] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization730hub # [ 3.149958] systemd[1]: Mounting /sysroot/nix/.rw-store...731worker # [ 0.338284] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier732worker # [ 0.340279] active return thunk: srso_alias_return_thunk733hub # [ 3.154435] systemd[1]: Mounting /sysroot/run...734worker # [ 0.341307] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'735worker # [ 0.343278] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'736worker # [ 0.345278] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'737worker # [ 0.347278] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'738worker # [ 0.348278] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'739hub # [ 3.168310] systemd[1]: Mounting /sysroot/tmp/shared...740worker # [ 0.349278] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'741worker # [ 0.350278] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'742worker # [ 0.351278] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'743hub # [ 3.175208] systemd[1]: Mounting /sysroot/tmp/xchg...744worker # [ 0.352278] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'745hub # [ 3.419552] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00746worker # [ 0.354279] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256747hub # [ 3.421460] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10748worker # [ 0.355278] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64749worker # [ 0.356278] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512750worker # [ 0.358278] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024751hub # [ 3.426590] usb 1-1: Product: QEMU USB Tablet752worker # [ 0.359278] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8753hub # [ 3.429097] usb 1-1: Manufacturer: QEMU754worker # [ 0.360279] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16755hub # [ 3.431100] usb 1-1: SerialNumber: 28754-0000:00:01.2-1756worker # [ 0.361278] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24757worker # [ 0.363278] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.758hub # [ 3.193513] systemd[1]: Starting Mountpoints Configured in the Real Root...759worker # [ 0.399541] Freeing SMP alternatives memory: 44K760worker # [ 0.400281] pid_max: default: 32768 minimum: 301761worker # [ 0.401393] LSM: initializing lsm=capability,landlock,yama,bpf,ima762worker # [ 0.403386] landlock: Up and running.763worker # [ 0.404278] Yama: becoming mindful.764worker # [ 0.405492] LSM support for eBPF active765hub # [ 3.476941] hid: raw HID events driver (C) Jiri Kosina766worker # [ 0.406375] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)767worker # [ 0.408329] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)768worker # [ 0.410689] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)769worker # [ 0.411869] Performance Events: Fam17h+ core perfctr, AMD PMU driver.770worker # [ 0.412289] ... version: 2771worker # [ 0.413280] ... bit width: 48772worker # [ 0.414280] ... generic counters: 6773hub # [ 3.491545] 9p: Installing v9fs 9p2000 file system support774worker # [ 0.415280] ... generic bitmap: 000000000000003f775worker # [ 0.416280] ... fixed-purpose counters: 0776worker # [ 0.417280] ... fixed-purpose bitmap: 0000000000000000777worker # [ 0.418280] ... value mask: 0000ffffffffffff778worker # [ 0.419280] ... max period: 00007fffffffffff779worker # [ 0.420280] ... global_ctrl mask: 000000000000003f780worker # [ 0.421410] signal: max sigframe size: 3376781hub # [ 3.258293] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload.782worker # [ 0.422385] rcu: Hierarchical SRCU implementation.783worker # [ 0.423310] rcu: Max phase no-delay instances is 400.784worker # [ 0.428836] smp: Bringing up secondary CPUs ...785worker # [ 0.429296] smp: Brought up 1 node, 1 CPU786worker # [ 0.430283] smpboot: Total of 1 processors activated (4800.03 BogoMIPS)787hub # [ 3.518151] usbcore: registered new interface driver usbhid788worker # [ 0.431519] Memory: 1969212K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved)789worker # [ 0.432565] devtmpfs: initialized790hub # [ 3.278111] systemd[1]: Mounted /sysroot/nix/.ro-store.791worker # [ 0.433507] x86/mm: Memory block size: 128MB792hub # [ 3.279557] systemd[1]: Mounted /sysroot/nix/.rw-store.793hub # [ 3.280963] systemd[1]: Mounted /sysroot/run.794worker # [ 0.435436] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns795hub # [ 3.282754] systemd[1]: Mounted /sysroot/tmp/shared.796worker # [ 0.436313] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)797hub # [ 3.285729] systemd[1]: Mounted /sysroot/tmp/xchg.798worker # [ 0.437308] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).799worker # [ 0.438369] pinctrl core: initialized pinctrl subsystem800worker # [ 0.439641] PM: RTC time: 09:51:25, date: 2026-07-13801hub # [ 3.537218] usbhid: USB HID core driver802worker # [ 0.443137] NET: Registered PF_NETLINK/PF_ROUTE protocol family803worker # [ 0.444781] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations804hub # [ 3.296594] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)...805worker # [ 0.445311] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations806hub # [ 3.300104] systemd[1]: Reloading...807worker # [ 0.446582] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations808worker # [ 0.447291] audit: initializing netlink subsys (disabled)809worker # [ 0.448529] thermal_sys: Registered thermal governor 'fair_share'810worker # [ 0.448531] thermal_sys: Registered thermal governor 'bang_bang'811worker # [ 0.449281] thermal_sys: Registered thermal governor 'step_wise'812worker # [ 0.450284] audit: type=2000 audit(1783936285.389:1): state=initialized audit_enabled=0 res=1813hub # [ 3.555366] 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/input2814worker # [ 0.452282] thermal_sys: Registered thermal governor 'user_space'815worker # [ 0.452284] thermal_sys: Registered thermal governor 'power_allocator'816worker # [ 0.453300] cpuidle: using governor menu817worker # [ 0.457338] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5818worker # [ 0.458579] PCI: Using configuration type 1 for base access819worker # [ 0.459281] PCI: Using configuration type 1 for extended access820hub # [ 3.567184] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0821worker # [ 0.460527] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.822worker # [ 0.465575] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages823worker # [ 0.466281] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page824worker # [ 0.471281] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages825worker # [ 0.472280] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page826worker # [ 0.482705] ACPI: Added _OSI(Module Device)827worker # [ 0.483282] ACPI: Added _OSI(Processor Device)828worker # [ 0.488280] ACPI: Added _OSI(Processor Aggregator Device)829worker # [ 0.493107] ACPI: 1 ACPI AML tables successfully acquired and loaded830worker # [ 0.497120] ACPI: Interpreter enabled831worker # [ 0.498184] ACPI: PM: (supports S0 S3 S4 S5)832worker # [ 0.501280] ACPI: Using IOAPIC for interrupt routing833worker # [ 0.502303] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug834worker # [ 0.505279] PCI: Using E820 reservations for host bridge windows835worker # [ 0.506430] ACPI: Enabled 2 GPEs in block 00 to 0F836worker # [ 0.514441] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])837worker # [ 0.515287] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]838worker # [ 0.516659] acpiphp: Slot [3] registered839worker # [ 0.517324] acpiphp: Slot [4] registered840worker # [ 0.518343] acpiphp: Slot [5] registered841worker # [ 0.519329] acpiphp: Slot [6] registered842worker # [ 0.520367] acpiphp: Slot [7] registered843worker # [ 0.521324] acpiphp: Slot [8] registered844worker # [ 0.522344] acpiphp: Slot [9] registered845worker # [ 0.523328] acpiphp: Slot [10] registered846worker # [ 0.524321] acpiphp: Slot [11] registered847worker # [ 0.525336] acpiphp: Slot [12] registered848worker # [ 0.526322] acpiphp: Slot [13] registered849hub # [ 3.409975] systemd[1]: Reloading finished in 110 ms.850worker # [ 0.527338] acpiphp: Slot [14] registered851worker # [ 0.528312] acpiphp: Slot [15] registered852worker # [ 0.529329] acpiphp: Slot [16] registered853worker # [ 0.530313] acpiphp: Slot [17] registered854worker # [ 0.531313] acpiphp: Slot [18] registered855worker # [ 0.532313] acpiphp: Slot [19] registered856worker # [ 0.533329] acpiphp: Slot [20] registered857worker # [ 0.534314] acpiphp: Slot [21] registered858worker # [ 0.535313] acpiphp: Slot [22] registered859hub # [ 3.420894] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace...860worker # [ 0.536313] acpiphp: Slot [23] registered861worker # [ 0.537331] acpiphp: Slot [24] registered862worker # [ 0.538314] acpiphp: Slot [25] registered863worker # [ 0.539313] acpiphp: Slot [26] registered864hub # [ 3.427123] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace...865worker # [ 0.540327] acpiphp: Slot [27] registered866worker # [ 0.541313] acpiphp: Slot [28] registered867worker # [ 0.542342] acpiphp: Slot [29] registered868worker # [ 0.543314] acpiphp: Slot [30] registered869hub # [ 3.431239] systemd[1]: initrd-parse-etc.service: Deactivated successfully.870worker # [ 0.544339] acpiphp: Slot [31] registered871worker # [ 0.545359] PCI host bridge to bus 0000:00872hub # [ 3.434109] systemd[1]: Finished Mountpoints Configured in the Real Root.873worker # [ 0.546288] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]874hub # [ 3.435855] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.875worker # [ 0.547281] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]876worker # [ 0.548282] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]877hub # [ 3.440111] systemd[1]: Starting rw-sysroot-nix-store.service...878worker # [ 0.549281] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window]879worker # [ 0.550281] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]880worker # [ 0.551281] pci_bus 0000:00: root bus resource [bus 00-ff]881worker # [ 0.552656] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint882worker # [ 0.554182] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint883hub # [ 3.451936] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.884hub # [ 3.454653] systemd[1]: Finished rw-sysroot-nix-store.service.885worker # [ 0.556235] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint886worker # [ 0.559128] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f]887worker # [ 0.560344] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk888worker # [ 0.561281] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk889worker # [ 0.562281] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk890worker # [ 0.563281] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk891worker # [ 0.564652] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint892worker # [ 0.566373] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f]893worker # [ 0.568518] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint894worker # [ 0.569895] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI895worker # [ 0.571322] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB896worker # [ 0.572678] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint897worker # [ 0.575373] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]898worker # [ 0.576310] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]899worker # [ 0.577332] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]900worker # [ 0.578516] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]901worker # [ 0.580471] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint902worker # [ 0.583318] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]903worker # [ 0.584295] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]904worker # [ 0.585333] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]905worker # [ 0.586295] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]906worker # [ 0.589463] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint907worker # [ 0.592317] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f]908worker # [ 0.593295] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]909worker # [ 0.594332] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]910worker # [ 0.597356] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint911worker # [ 0.600255] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf]912worker # [ 0.601294] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]913worker # [ 0.602332] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]914worker # [ 0.605252] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint915worker # [ 0.608256] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df]916worker # [ 0.609297] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]917worker # [ 0.610333] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]918worker # [ 0.613294] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint919worker # [ 0.616320] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]920worker # [ 0.617299] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]921worker # [ 0.618349] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]922worker # [ 0.621622] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint923worker # [ 0.624345] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff]924worker # [ 0.625295] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]925worker # [ 0.626332] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]926worker # [ 0.629465] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint927worker # [ 0.632319] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff]928worker # [ 0.633295] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]929worker # [ 0.634332] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]930worker # [ 0.635295] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]931worker # [ 0.638246] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint932worker # [ 0.640559] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]933worker # [ 0.641332] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]934worker # [ 0.644306] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint935worker # [ 0.647871] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f]936worker # [ 0.648295] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]937worker # [ 0.649332] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]938worker # [ 0.652294] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint939worker # [ 0.655243] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f]940worker # [ 0.656294] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]941worker # [ 0.657332] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]942worker # [ 0.665545] ACPI: PCI: Interrupt link LNKA configured for IRQ 10943worker # [ 0.666490] ACPI: PCI: Interrupt link LNKB configured for IRQ 10944worker # [ 0.667474] ACPI: PCI: Interrupt link LNKC configured for IRQ 11945worker # [ 0.668467] ACPI: PCI: Interrupt link LNKD configured for IRQ 11946worker # [ 0.669392] ACPI: PCI: Interrupt link LNKS configured for IRQ 9947worker # [ 0.671535] iommu: Default domain type: Translated948worker # [ 0.672290] iommu: DMA domain TLB invalidation policy: lazy mode949worker # [ 0.673573] ACPI: bus type USB registered950worker # [ 0.674343] usbcore: registered new interface driver usbfs951worker # [ 0.675315] usbcore: registered new interface driver hub952worker # [ 0.676290] usbcore: registered new device driver usb953worker # [ 0.678241] NetLabel: Initializing954worker # [ 0.679110] NetLabel: domain hash size = 128955worker # [ 0.680280] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO956worker # [ 0.681330] NetLabel: unlabeled traffic allowed by default957worker # [ 0.682296] PCI: Using ACPI for IRQ routing958worker # [ 0.683959] pci 0000:00:02.0: vgaarb: setting as boot VGA device959worker # [ 0.684275] pci 0000:00:02.0: vgaarb: bridge control possible960worker # [ 0.684275] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none961worker # [ 0.684283] vgaarb: loaded962worker # [ 0.685442] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0963worker # [ 0.686280] hpet0: 3 comparators, 64-bit 100.000000 MHz counter964worker # [ 0.690367] clocksource: Switched to clocksource kvm-clock965worker # [ 0.692606] VFS: Disk quotas dquot_6.6.0966worker # [ 0.695835] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)967worker # [ 0.698055] pnp: PnP ACPI init968worker # [ 0.699698] pnp: PnP ACPI: found 6 devices969worker # [ 0.707976] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns970worker # [ 0.710508] clocksource: Switched to clocksource acpi_pm971worker # [ 0.712233] NET: Registered PF_INET protocol family972worker # [ 0.714121] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)973worker # [ 0.733017] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)974worker # [ 0.735641] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)975worker # [ 0.737940] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)976worker # [ 0.740277] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)977worker # [ 0.742456] TCP: Hash tables configured (established 16384 bind 16384)978worker # [ 0.744446] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)979worker # [ 0.746690] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)980worker # [ 0.748667] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)981worker # [ 0.750888] NET: Registered PF_UNIX/PF_LOCAL protocol family982worker # [ 0.752593] NET: Registered PF_XDP protocol family983worker # [ 0.754133] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]984worker # [ 0.755928] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]985worker # [ 0.757711] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]986worker # [ 0.759716] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window]987worker # [ 0.761723] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]988worker # [ 0.763944] pci 0000:00:01.0: PIIX3: Enabling Passive Release989worker # [ 0.765667] pci 0000:00:00.0: Limiting direct PCI/PCI transfers990worker # [ 0.769059] ACPI: \_SB_.LNKD: Enabled at IRQ 11991worker # [ 0.772439] PCI: CLS 0 bytes, default 64992worker # [ 0.773978] Trying to unpack rootfs image as initramfs...993worker # [ 0.779036] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns994worker # [ 0.824295] Initialise system trusted keyrings995worker # [ 0.828914] workingset: timestamp_bits=40 max_order=19 bucket_order=0996worker # [ 0.852477] Key type asymmetric registered997worker # [ 0.858889] Asymmetric key parser 'x509' registered998worker # [ 0.860445] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)999worker # [ 0.867016] io scheduler mq-deadline registered1000worker # [ 0.868415] io scheduler kyber registered1001worker # [ 0.873883] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1002worker # [ 0.879282] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1003worker # [ 0.886078] Linux agpgart interface v0.1031004worker # [ 0.887416] ACPI: bus type drm_connector registered1005worker # [ 0.894031] usbcore: registered new interface driver usbserial_generic1006hub # [ 3.889290] systemd[1]: Mounting /sysroot/nix/store...1007worker # [ 0.895930] usbserial: USB Serial support registered for generic1008worker # [ 0.900874] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.1009worker # [ 0.900874] Please enable it if your BIOS has the CPPC option.1010worker # [ 0.911874] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1011worker # [ 0.914234] drop_monitor: Initializing network drop monitor service1012worker # [ 0.921003] NET: Registered PF_INET6 protocol family1013worker # [ 0.926178] Segment Routing with IPv61014worker # [ 0.927379] In-situ OAM (IOAM) with IPv61015worker # [ 0.931247] IPI shorthand broadcast: enabled1016worker # [ 0.940042] sched_clock: Marking stable (701029550, 238820506)->(1135604763, -195754707)1017hub # [ 3.941148] systemd[1]: Mounted /sysroot/nix/store.1018hub # [ 3.942529] systemd[1]: Reached target Initrd File Systems.1019hub # [ 3.945128] systemd[1]: Starting Find NixOS closure...1020worker # [ 0.948127] registered taskstats version 11021worker # [ 0.949653] Loading compiled-in X.509 certificates1022hub # [ 3.950154] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1023worker # [ 0.971879] Demotion targets for Node 0: null1024worker # [ 0.974919] Key type .fscrypt registered1025hub # [ 3.972168] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1026worker # [ 0.977880] Key type fscrypt-provisioning registered1027worker # [ 0.979542] ima: No TPM chip found, activating TPM-bypass!1028hub # [ 3.977099] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1029worker # [ 0.983888] ima: Allocated hash algorithm: sha11030worker # [ 0.985336] ima: No architecture policies found1031hub # [ 3.985928] systemd[1]: Finished Find NixOS closure.1032worker # [ 0.991068] PM: Magic number: 2:276:8791033hub # [ 3.988216] systemd[1]: Reached target Initrd Default Target.1034hub # [ 3.990576] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1035worker # [ 0.995304] RAS: Correctable Errors collector initialized.1036worker # [ 1.004753] clk: Disabling unused clocks1037worker # [ 1.009887] PM: genpd: Disabling unused power domains1038hub # [ 4.008381] systemd[1]: Stopped target Initrd Default Target.1039hub # [ 4.009925] systemd[1]: Stopped target Basic System.1040hub # [ 4.011343] systemd[1]: Stopped target Initrd Root Device.1041hub # [ 4.012975] systemd[1]: Stopped target Path Units.1042hub # [ 4.014521] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1043hub # [ 4.017238] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1044hub # [ 4.019329] systemd[1]: Stopped target Slice Units.1045hub # [ 4.021148] systemd[1]: Stopped target Socket Units.1046hub # [ 4.023211] systemd[1]: Stopped target System Initialization.1047hub # [ 4.024838] systemd[1]: Stopped target Swaps.1048hub # [ 4.027193] systemd[1]: Stopped target Timer Units.1049hub # [ 4.028568] systemd[1]: dbus.socket: Deactivated successfully.1050hub # [ 4.030164] systemd[1]: Closed D-Bus System Message Bus Socket.1051hub # [ 4.032323] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1052hub # [ 4.035251] systemd[1]: Stopped Find NixOS closure.1053hub # [ 4.036587] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1054hub # [ 4.039270] systemd[1]: Starting rw-sysroot-nix-store.service...1055hub # [ 4.041519] systemd[1]: systemd-sysctl.service: Deactivated successfully.1056hub # [ 4.044243] systemd[1]: Stopped Apply Kernel Variables.1057hub # [ 4.045752] systemd[1]: systemd-modules-load.service: Deactivated successfully.1058hub # [ 4.047761] systemd[1]: Stopped Load Kernel Modules.1059hub # [ 4.050220] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1060hub # [ 4.052216] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1061hub # [ 4.054342] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1062hub # [ 4.056207] systemd[1]: Stopped Create System Files and Directories.1063hub # [ 4.058244] systemd[1]: Stopped target Local File Systems.1064hub # [ 4.060339] systemd[1]: Stopped target Preparation for Local File Systems.1065hub # [ 4.063241] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1066hub # [ 4.065578] systemd[1]: Stopped Coldplug All udev Devices.1067hub # [ 4.068087] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1068hub # [ 4.070298] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1069hub # [ 4.073189] systemd[1]: Stopped Virtual Console Setup.1070hub # [ 4.083126] systemd[1]: initrd-cleanup.service: Deactivated successfully.1071hub # [ 4.088137] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1072hub # [ 4.096764] systemd[1]: systemd-udevd.service: Deactivated successfully.1073hub # [ 4.099371] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1074hub # [ 4.102504] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1075hub # [ 4.104453] systemd[1]: Finished rw-sysroot-nix-store.service.1076hub # [ 4.106832] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1077hub # [ 4.109230] systemd[1]: Closed udev Control Socket.1078hub # [ 4.111922] systemd[1]: Starting Cleanup udev Database...1079hub # [ 4.113406] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1080hub # [ 4.115357] systemd[1]: Stopped Create Static Device Nodes in /dev.1081hub # [ 4.117251] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1082hub # [ 4.120263] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1083hub # [ 4.122146] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1084hub # [ 4.123902] systemd[1]: Stopped Create List of Static Device Nodes.1085hub # [ 4.140479] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1086hub # [ 4.143185] systemd[1]: Finished Cleanup udev Database.1087worker # [ 1.146400] Freeing initrd memory: 29528K1088hub # [ 4.145148] systemd[1]: Reached target Switch Root.1089worker # [ 1.150307] Freeing unused decrypted memory: 2028K1090hub # [ 4.148085] systemd[1]: Starting NixOS Activation...1091worker # [ 1.153740] Freeing unused kernel image (initmem) memory: 3636K1092worker # [ 1.155636] Write protecting the kernel read-only data: 32768k1093worker # [ 1.158488] Freeing unused kernel image (text/rodata gap) memory: 1272K1094worker # [ 1.160976] Freeing unused kernel image (rodata/data gap) memory: 796K1095worker # [ 1.213893] x86/mm: Checked W+X mappings: passed, no W+X pages found.1096worker # [ 1.215798] Run /init as init process1097worker # [ 1.227371] systemd[1]: Inserted module 'autofs4'1098worker # [ 1.244228] fuse: init (API version 7.45)1099worker # [ 1.251727] ACPI: \_SB_.LNKC: Enabled at IRQ 101100worker # [ 1.260615] ACPI: \_SB_.LNKA: Enabled at IRQ 101101worker # [ 1.265310] ACPI: \_SB_.LNKB: Enabled at IRQ 111102worker # [ 1.304927] systemd[1]: Successfully made /usr/ read-only.1103hub # [ 4.316887] initrd-nixos-activation-start[181]: booting system configuration /nix/store/5l4rqpz1z88102k8cdlr82im0i0viv2b-nixos-system-hub-test1104hub # [ 4.386103] initrd-nixos-activation-start[181]: running activation script...1105worker # [ 1.644241] 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.665752] systemd[1]: Detected virtualization kvm.1107worker # [ 1.669693] systemd[1]: Detected architecture x86-64.1108worker # [ 1.673690] systemd[1]: Running in initrd.1109worker # [ 1.677782] systemd[1]: Initializing machine ID from random generator.1110worker # [ 1.683080] systemd[1]: Hostname set to <worker>.1111hub # [ 4.832541] initrd-nixos-activation-start[204]: setting up /etc...1112worker # [ 1.904485] systemd[1]: bpf-restrict-fs: LSM BPF program attached1113worker # [ 1.964909] systemd[1]: Queued start job for default target Initrd Default Target.1114worker # [ 1.969551] systemd[1]: Created slice Slice /system/modprobe.1115worker # [ 1.971609] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1116worker # [ 1.974065] systemd[1]: Expecting device /dev/disk/by-label/nix-store...1117worker # [ 1.976133] systemd[1]: Expecting device /dev/disk/by-label/nixos...1118worker # [ 1.978104] systemd[1]: Reached target Path Units.1119worker # [ 1.979645] systemd[1]: Reached target Slice Units.1120worker # [ 1.981268] systemd[1]: Reached target Swaps.1121worker # [ 1.982699] systemd[1]: Reached target Timer Units.1122worker # [ 1.984445] systemd[1]: Listening on D-Bus System Message Bus Socket.1123worker # [ 1.986575] systemd[1]: Listening on Journal Socket (/dev/log).1124worker # [ 1.988650] systemd[1]: Listening on Journal Sockets.1125worker # [ 1.990452] systemd[1]: Listening on udev Control Socket.1126worker # [ 1.992260] systemd[1]: Listening on udev Kernel Socket.1127worker # [ 1.993947] systemd[1]: Reached target Socket Units.1128worker # [ 1.996611] systemd[1]: Starting Create List of Static Device Nodes...1129worker # [ 2.003009] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1130worker # [ 2.013603] systemd[1]: Starting Load Kernel Module configfs...1131worker # [ 2.026090] systemd[1]: Starting Journal Service...1132worker # [ 2.040948] systemd[1]: Starting Load Kernel Modules...1133worker # [ 2.051017] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1134worker # [ 2.070599] netfs: FS-Cache loaded1135worker # [ 2.085057] 9pnet: Installing 9P2000 support1136worker # [ 2.099796] systemd-journald[67]: Collecting audit messages is disabled.1137worker # [ 2.102630] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1138worker # [ 2.110247] systemd[1]: Starting Coldplug All udev Devices...1139worker # [ 2.115016] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1140worker # [ 2.129986] systemd[1]: Finished Create List of Static Device Nodes.1141hub # [ 5.129713] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1142hub # [ 5.132125] systemd[1]: Finished NixOS Activation.1143hub # [ 5.134871] systemd[1]: Starting Switch Root...1144worker # [ 2.139608] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1145worker # [ 2.150958] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1146hub # [ 5.150441] systemd[1]: Switching root.1147worker # [ 2.156409] systemd[1]: modprobe@configfs.service: Deactivated successfully.1148worker # [ 2.165488] systemd[1]: Finished Load Kernel Module configfs.1149worker # [ 2.175006] systemd[1]: Finished Load Kernel Modules.1150worker # [ 2.179662] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1151worker # [ 2.194116] systemd[1]: Starting Apply Kernel Variables...1152worker # [ 2.211947] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1153worker # [ 2.248066] systemd[1]: Finished Apply Kernel Variables.1154worker # [ 2.256023] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1155worker # [ 2.266993] systemd[1]: Starting Create Static Device Nodes in /dev...1156hub # [ 5.528881] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1157worker # [ 2.052309] systemd-modules-load[68]: Inserted module 'dm_mod'[ 2.293038] systemd[1]: Started Journal Service.1158worker # 1159worker # [ 2.057566] systemd-modules-load[68]: Inserted module 'virtio_balloon'1160worker # [ 2.062121] systemd-modules-load[68]: Inserted module 'virtio_gpu'1161worker # [ 2.073325] systemd[1]: Finished Create Static Device Nodes in /dev.1162worker # [ 2.081133] systemd[1]: Reached target Preparation for Local File Systems.1163worker # [ 2.083063] systemd[1]: Reached target Local File Systems.1164worker # [ 2.085631] systemd[1]: Starting Create System Files and Directories...1165worker # [ 2.095112] systemd[1]: Starting Rule-based Manager for Device Events and Files...1166worker # [ 2.127672] systemd[1]: Finished Create System Files and Directories.1167worker # [ 2.148541] systemd-udevd[83]: Using default interface naming scheme 'v261'.1168worker # [ 2.183325] systemd[1]: Started Rule-based Manager for Device Events and Files.1169hub # [ 5.681888] NET: Registered PF_VSOCK protocol family1170worker # [ 2.230154] systemd[1]: Finished Coldplug All udev Devices.1171worker # [ 2.231741] systemd[1]: Reached target System Initialization.1172worker # [ 2.233306] systemd[1]: Reached target Basic System.1173worker # [ 2.716180] virtio_blk virtio4: 1/0/0 default/read/poll queues1174worker # [ 2.751643] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1175worker # [ 2.759368] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121176worker # [ 2.784426] uhci_hcd 0000:00:01.2: UHCI Host Controller1177worker # [ 2.799074] serio: i8042 KBD port at 0x60,0x64 irq 11178worker # [ 2.814315] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 11179worker # [ 2.816633] virtio_blk virtio5: 1/0/0 default/read/poll queues1180worker # [ 2.823049] serio: i8042 AUX port at 0x60,0x64 irq 121181worker # [ 2.832989] uhci_hcd 0000:00:01.2: detected 2 ports1182worker # [ 2.836929] virtio_blk virtio5: [vdb] 2081904 512-byte logical blocks (1.07 GB/1017 MiB)1183worker # [ 2.842649] SCSI subsystem initialized1184hub # [ 6.069734] 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)1185worker # [ 2.844109] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c1401186hub # [ 6.085772] systemd[1]: Detected virtualization kvm.1187hub # [ 6.088915] systemd[1]: Detected architecture x86-64.1188hub # [ 6.092288] systemd[1]: Detected first boot.1189worker # [ 2.859501] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181190hub # [ 6.099841] systemd[1]: Initializing machine ID from random generator.1191worker # [ 2.874617] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11192worker # [ 2.890864] usb usb1: Product: UHCI Host Controller1193worker # [ 2.903137] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd1194worker # [ 2.667097] systemd[1]: Starting Virtual Console Setup...1195worker # [ 2.941863] usb usb1: SerialNumber: 0000:00:01.21196worker # [ 2.705260] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1197worker # [ 2.710730] systemd[1]: Finished Virtual Console Setup.1198worker # [ 2.713649] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.1199worker # [ 2.717842] (udev-worker)[88]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1200worker # [ 2.721624] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1201worker # [ 2.965993] hub 1-0:1.0: USB hub found1202worker # [ 2.973918] hub 1-0:1.0: 2 ports detected1203hub # [ 6.237218] systemd[1]: bpf-restrict-fs: LSM BPF program attached1204worker # [ 3.007099] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01205worker # [ 2.778468] systemd[1]: Found device /dev/disk/by-label/nixos.1206worker # [ 2.782076] systemd[1]: Reached target Initrd Root Device.1207worker # [ 2.784450] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1208worker # [ 2.797977] systemd[1]: Found device /dev/disk/by-label/nix-store.1209worker # [ 3.047898] scsi host0: ata_piix1210worker # [ 3.056700] scsi host1: ata_piix1211worker # [ 3.059409] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 01212worker # [ 2.828915] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks1213worker # [ 3.070903] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 01214worker # [ 2.837323] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1215worker # [ 2.885276] systemd[1]: Mounting /sysroot...1216hub # [ 6.367947] systemd[1]: Applying preset policy.1217worker # [ 3.208025] usb 1-1: new full-speed USB device number 2 using uhci_hcd1218worker # [ 3.232486] ata2: found unknown device (class 0)1219worker # [ 3.237717] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001220worker # [ 3.246515] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51221worker # [ 3.312613] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1222worker # [ 3.330370] cdrom: Uniform CD-ROM driver Revision: 3.201223worker # [ 3.358273] EXT4-fs (vda): mounted filesystem 0e430e08-18d4-417f-b7e2-f6ddb956521c r/w with ordered data mode. Quota mode: none.1224worker # [ 3.125723] systemd[1]: Mounted /sysroot.1225worker # [ 3.129194] systemd[1]: Reached target Initrd Root File System.1226worker # [ 3.135103] systemd[1]: Starting Mountpoints Configured in the Real Root...1227worker # [ 3.378300] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001228worker # [ 3.380228] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101229worker # [ 3.382260] usb 1-1: Product: QEMU USB Tablet1230worker # [ 3.385857] usb 1-1: Manufacturer: QEMU1231worker # [ 3.387856] usb 1-1: SerialNumber: 28754-0000:00:01.2-11232worker # [ 3.155927] systemd-sysroot-fstab-check[128]: /sysroot should be mounted in the initrd, will request daemon-reload.1233worker # [ 3.163101] systemd[1]: Reload requested from client PID 128 ('systemd-sysroot') (unit initrd-parse-etc.service)...1234worker # [ 3.165767] systemd[1]: Reloading...1235worker # [ 3.444573] hid: raw HID events driver (C) Jiri Kosina1236worker # [ 3.466576] usbcore: registered new interface driver usbhid1237worker # [ 3.475862] usbhid: USB HID core driver1238worker # [ 3.488138] 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.495922] 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.326905] systemd[1]: Reloading finished in 164 ms.1241worker # [ 3.336857] systemd-sysroot-fstab-check[128]: Requesting initrd-fs.target/start/replace...1242worker # [ 3.344197] systemd-sysroot-fstab-check[128]: Requesting swap.target/start/replace...1243worker # [ 3.348077] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1244worker # [ 3.353485] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1245worker # [ 3.355479] systemd[1]: Finished Mountpoints Configured in the Real Root.1246worker # [ 3.358079] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1247hub # [ 6.901900] systemd[1]: Populated /etc with preset unit settings.1248worker # [ 3.890927] systemd[1]: Mounting /sysroot/nix/.ro-store...1249worker # [ 3.899272] systemd[1]: Mounting /sysroot/nix/.rw-store...1250worker # [ 3.910298] systemd[1]: Mounting /sysroot/run...1251worker # [ 3.925948] systemd[1]: Mounting /sysroot/tmp/shared...1252worker # [ 3.945410] systemd[1]: Mounting /sysroot/tmp/xchg...1253hub # [ 7.431948] systemd[1]: initrd-switch-root.service: Deactivated successfully.1254hub # [ 7.434449] systemd[1]: Stopped initrd-switch-root.service.1255hub # [ 7.438114] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1256hub # [ 7.441237] systemd[1]: Created slice Slice /system/getty.1257hub # [ 7.443292] systemd[1]: Created slice User and Session Slice.1258hub # [ 7.444831] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1259hub # [ 7.446877] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1260hub # [ 7.448748] systemd[1]: Expecting device /dev/hvc0...1261hub # [ 7.450001] systemd[1]: Expecting device /dev/ttyS0...1262hub # [ 7.451347] systemd[1]: Reached target Local Encrypted Volumes.1263hub # [ 7.452771] systemd[1]: Stopped target initrd-fs.target.1264hub # [ 7.454113] systemd[1]: Stopped target initrd-root-fs.target.1265hub # [ 7.455495] systemd[1]: Stopped target initrd-switch-root.target.1266hub # [ 7.457000] systemd[1]: Reached target Virtual Machines and Containers.1267worker # [ 3.978320] systemd[1]: Mounted /sysroot/nix/.rw-store.1268hub # [ 7.458650] systemd[1]: Reached target Path Units.1269hub # [ 7.459893] systemd[1]: Reached target Remote File Systems.1270worker # [ 4.219919] erofs (device vdb): mounted with root inode @ nid 36.1271hub # [ 7.461330] systemd[1]: Reached target Slice Units.1272hub # [ 7.462596] systemd[1]: Reached target Swaps.1273hub # [ 7.467097] systemd[1]: Listening on Query the User Interactively for a Password.1274worker # [ 3.990179] systemd[1]: Mounted /sysroot/run.1275worker # [ 4.231379] 9p: Installing v9fs 9p2000 file system support1276hub # [ 7.472399] systemd[1]: Listening on Process Core Dump Socket.1277hub # [ 7.476392] systemd[1]: Listening on Credential Encryption/Decryption.1278hub # [ 7.480312] systemd[1]: Listening on Factory Reset Management.1279hub # [ 7.481858] systemd[1]: Listening on Hostname Service Socket.1280worker # [ 4.003344] systemd[1]: Mounted /sysroot/nix/.ro-store.1281worker # [ 4.005467] systemd[1]: Mounted /sysroot/tmp/shared.1282hub # [ 7.487328] systemd[1]: Starting Journal Log Access Socket...1283worker # [ 4.010506] systemd[1]: Mounted /sysroot/tmp/xchg.1284hub # [ 7.489676] systemd[1]: Listening on Journal Audit Socket.1285worker # [ 4.014761] systemd[1]: Starting rw-sysroot-nix-store.service...1286hub # [ 7.493800] systemd[1]: Listening on Console Output Muting Service Socket.1287hub # [ 7.495680] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1288hub # [ 7.497900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1289hub # [ 7.500152] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1290worker # [ 4.026941] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1291worker # [ 4.029880] systemd[1]: Finished rw-sysroot-nix-store.service.1292hub # [ 7.512914] systemd[1]: Listening on Disk Repartitioning Service Socket.1293hub # [ 7.514723] systemd[1]: Listening on udev Control Socket.1294hub # [ 7.516287] systemd[1]: Listening on udev Varlink Socket.1295hub # [ 7.521226] systemd[1]: Mounting Huge Pages File System...1296hub # [ 7.525633] systemd[1]: Mounting POSIX Message Queue File System...1297hub # [ 7.533576] systemd[1]: Mounting Kernel Debug File System...1298hub # [ 7.541305] systemd[1]: Mounting Kernel Trace File System...1299hub # [ 7.546900] systemd[1]: Starting Create List of Static Device Nodes...1300hub # [ 7.551567] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1301hub # [ 7.565662] systemd[1]: Starting Load Kernel Module configfs...1302hub # [ 7.568311] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1303hub # [ 7.570737] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1304hub # [ 7.577576] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1305hub # [ 7.608604] systemd[1]: Mounting FUSE Control File System...1306hub # [ 7.619367] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671307hub # [ 7.641438] systemd[1]: Starting Journal Service...1308hub # [ 7.649411] systemd[1]: Starting Load Kernel Modules...1309hub # [ 7.663236] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1310hub # [ 7.671514] systemd[1]: Starting Remount Root and Kernel File Systems...1311hub # [ 7.682416] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1312hub # [ 7.699337] systemd[1]: Starting Coldplug All udev Devices...1313hub # [ 7.714642] systemd-journald[274]: Collecting audit messages is enabled.1314hub # [ 7.731233] loop: module loaded1315hub # [ 7.732850] systemd[1]: Listening on Journal Log Access Socket.1316hub # [ 7.742236] systemd[1]: Mounted Huge Pages File System.1317hub # [ 7.752217] systemd[1]: Mounted POSIX Message Queue File System.1318hub # [ 7.758789] systemd[1]: Mounted Kernel Debug File System.1319hub # [ 7.760740] EXT4-fs (vda): re-mounted 30e3ae72-0269-40f2-9ac9-4e30361a4f77.1320hub # [ 7.770001] systemd[1]: Mounted Kernel Trace File System.1321hub # [ 7.784320] systemd[1]: Finished Create List of Static Device Nodes.1322hub # [ 7.793289] systemd[1]: modprobe@configfs.service: Deactivated successfully.1323hub # [ 7.555065] systemd[1]: Queued start job for default target Multi-User System.1324hub # [ 7.801772] systemd[1]: Finished Load Kernel Module configfs.1325hub # [ 7.560460] systemd[1]: systemd-journald.service: Deactivated successfully.1326hub # [ 7.562804] systemd-modules-load[275]: Inserted module 'loop'1327hub # [ 7.567498] systemd-modules-load[275]: Inserted module 'tls'1328hub # [ 7.814400] systemd[1]: Started Journal Service.1329hub # [ 7.579900] systemd[1]: Mounted FUSE Control File System.1330hub # [ 7.586136] systemd[1]: Finished Load Kernel Modules.1331hub # [ 7.587623] systemd[1]: Finished Remount Root and Kernel File Systems.1332hub # [ 7.607469] systemd-oomd[277]: No swap; memory pressure usage will be degraded1333hub # [ 7.611414] systemd[1]: Listening on Disk Image Download Service Socket.1334hub # [ 7.619158] systemd[1]: Mounting Kernel Configuration File System...1335hub # [ 7.624375] systemd[1]: Starting Firewall...1336hub # [ 7.635524] systemd[1]: Starting Flush Journal to Persistent Storage...1337hub # [ 7.639287] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1338hub # [ 7.648479] systemd[1]: Starting Load/Save OS Random Seed...1339hub # [ 7.664329] systemd[1]: Starting Apply Kernel Variables...1340hub # [ 7.679115] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1341hub # [ 7.683211] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1342hub # [ 7.687827] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1343hub # [ 7.975446] systemd-journald[274]: Received client request to flush runtime journal.1344hub # [ 7.942855] systemd[1]: Mounted Kernel Configuration File System.1345hub # [ 7.950185] systemd[1]: Finished Load/Save OS Random Seed.1346hub # [ 7.952431] systemd[1]: Reached target First Boot Complete.1347hub # [ 7.956899] systemd[1]: Finished Apply Kernel Variables.1348hub # [ 7.959481] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1349hub # [ 7.961830] systemd[1]: Starting Create Static Device Nodes in /dev...1350hub # [ 7.965247] systemd[1]: Finished Flush Journal to Persistent Storage.1351hub # [ 8.002216] systemd[1]: Finished Create Static Device Nodes in /dev.1352hub # [ 8.004880] systemd[1]: Reached target Preparation for Local File Systems.1353hub # [ 8.011886] systemd[1]: Starting Rule-based Manager for Device Events and Files...1354hub # [ 8.079967] systemd[1]: Finished Coldplug All udev Devices.1355hub # [ 8.110693] systemd-udevd[318]: Using default interface naming scheme 'v261'.1356worker # [ 4.888299] systemd[1]: Mounting /sysroot/nix/store...1357worker # [ 4.939641] systemd[1]: Mounted /sysroot/nix/store.1358worker # [ 4.942228] systemd[1]: Reached target Initrd File Systems.1359worker # [ 4.944843] systemd[1]: Starting Find NixOS closure...1360worker # [ 4.952128] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1361hub # [ 8.194783] systemd[1]: Mounting /run/wrappers...1362worker # [ 4.974865] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1363worker # [ 4.979388] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1364worker # [ 4.989211] systemd[1]: Finished Find NixOS closure.1365worker # [ 4.991557] systemd[1]: Reached target Initrd Default Target.1366worker # [ 4.994912] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1367hub # [ 8.232643] systemd[1]: Mounted /run/wrappers.1368hub # [ 8.236144] systemd[1]: Reached target Local File Systems.1369hub # [ 8.243182] systemd[1]: Listening on Boot Loader Control Service Socket.1370worker # [ 5.011230] systemd[1]: Stopped target Initrd Default Target.1371hub # [ 8.247868] systemd[1]: Starting register-nix-paths.service...1372worker # [ 5.013502] systemd[1]: Stopped target Basic System.1373worker # [ 5.016219] systemd[1]: Stopped target Initrd Root Device.1374worker # [ 5.017783] systemd[1]: Stopped target Path Units.1375hub # [ 8.254545] systemd[1]: Starting Create SUID/SGID Wrappers...1376worker # [ 5.019897] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1377hub # [ 8.257193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1378worker # [ 5.021827] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1379worker # [ 5.024236] systemd[1]: Stopped target Slice Units.1380worker # [ 5.026368] systemd[1]: Stopped target Socket Units.1381worker # [ 5.029071] systemd[1]: Stopped target System Initialization.1382worker # [ 5.030580] systemd[1]: Stopped target Swaps.1383worker # [ 5.031928] systemd[1]: Stopped target Timer Units.1384worker # [ 5.033491] systemd[1]: dbus.socket: Deactivated successfully.1385hub # [ 8.270624] systemd[1]: Starting Save Transient machine-id to Disk...1386worker # [ 5.035482] systemd[1]: Closed D-Bus System Message Bus Socket.1387worker # [ 5.037215] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1388worker # [ 5.040220] systemd[1]: Stopped Find NixOS closure.1389worker # [ 5.041631] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1390worker # [ 5.044431] systemd[1]: Starting rw-sysroot-nix-store.service...1391worker # [ 5.046290] systemd[1]: systemd-sysctl.service: Deactivated successfully.1392worker # [ 5.048427] systemd[1]: Stopped Apply Kernel Variables.1393worker # [ 5.050302] systemd[1]: systemd-modules-load.service: Deactivated successfully.1394hub # [ 8.286625] systemd[1]: Starting Create System Files and Directories...1395worker # [ 5.053210] systemd[1]: Stopped Load Kernel Modules.1396worker # [ 5.054564] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1397hub # [ 8.291421] systemd[1]: Started Rule-based Manager for Device Events and Files.1398worker # [ 5.056575] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1399worker # [ 5.058985] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1400worker # [ 5.061192] systemd[1]: Stopped Create System Files and Directories.1401worker # [ 5.063261] systemd[1]: Stopped target Local File Systems.1402worker # [ 5.065564] systemd[1]: Stopped target Preparation for Local File Systems.1403worker # [ 5.069128] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1404worker # [ 5.070943] systemd[1]: Stopped Coldplug All udev Devices.1405worker # [ 5.074757] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1406worker # [ 5.076638] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1407worker # [ 5.078463] systemd[1]: Stopped Virtual Console Setup.1408worker # [ 5.089131] systemd[1]: initrd-cleanup.service: Deactivated successfully.1409worker # [ 5.093656] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1410worker # [ 5.102347] systemd[1]: systemd-udevd.service: Deactivated successfully.1411worker # [ 5.104939] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1412worker # [ 5.107546] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1413worker # [ 5.110113] systemd[1]: Finished rw-sysroot-nix-store.service.1414worker # [ 5.112566] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1415worker # [ 5.115221] systemd[1]: Closed udev Control Socket.1416worker # [ 5.116929] systemd[1]: Starting Cleanup udev Database...1417worker # [ 5.119127] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1418worker # [ 5.121139] systemd[1]: Stopped Create Static Device Nodes in /dev.1419worker # [ 5.123221] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1420worker # [ 5.125286] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1421hub # [ 8.361506] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1422worker # [ 5.128195] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1423worker # [ 5.129938] systemd[1]: Stopped Create List of Static Device Nodes.1424hub # [ 8.372545] systemd[1]: Finished Save Transient machine-id to Disk.1425worker # [ 5.147531] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1426worker # [ 5.150394] systemd[1]: Finished Cleanup udev Database.1427worker # [ 5.152525] systemd[1]: Reached target Switch Root.1428worker # [ 5.154979] systemd[1]: Starting NixOS Activation...1429hub # [ 8.447726] systemd[1]: Finished Create System Files and Directories.1430worker # [ 5.210977] initrd-nixos-activation-start[183]: booting system configuration /nix/store/5yvayla79h0dwkrrlvkr19gvb00m07fh-nixos-system-worker-test1431hub # [ 8.460503] systemd[1]: Starting Rebuild Journal Catalog...1432worker # [ 5.232295] initrd-nixos-activation-start[183]: running activation script...1433hub # [ 8.472579] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1434hub # [ 8.557827] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1435worker # [ 5.371488] initrd-nixos-activation-start[206]: setting up /etc...1436hub # [ 8.609229] systemd[1]: Finished Rebuild Journal Catalog.1437hub # [ 8.619426] systemd[1]: Starting Update is Completed...1438hub # [ 8.676927] systemd[1]: Finished Update is Completed.1439worker # [ 5.443470] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1440worker # [ 5.446215] systemd[1]: Finished NixOS Activation.1441worker # [ 5.449151] systemd[1]: Starting Switch Root...1442worker # [ 5.463639] systemd[1]: Switching root.1443hub # [ 8.801436] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1444worker # [ 5.828318] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1445worker # [ 5.896033] NET: Registered PF_VSOCK protocol family1446hub # [ 8.985404] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1447hub # [ 8.989798] systemd[1]: Finished Create SUID/SGID Wrappers.1448hub # [ 9.039919] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1449hub # [ 9.126884] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1450hub # [ 9.165181] (udev-worker)[406]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1451hub # [ 9.177684] (udev-worker)[406]: Network interface NamePolicy= disabled on kernel command line.1452hub # [ 9.180713] (udev-worker)[397]: Network interface NamePolicy= disabled on kernel command line.1453worker # [ 6.254218] 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.270498] systemd[1]: Detected virtualization kvm.1455worker # [ 6.273669] systemd[1]: Detected architecture x86-64.1456worker # [ 6.277045] systemd[1]: Detected first boot.1457worker # [ 6.280971] systemd[1]: Initializing machine ID from random generator.1458hub # [ 9.294224] systemd[1]: Finished register-nix-paths.service.1459hub # [ 9.295958] systemd[1]: Reached target System Initialization.1460hub # [ 9.300535] systemd[1]: Started Discard unused filesystem blocks once a week.1461hub # [ 9.302740] systemd[1]: Started Daily Cleanup of Temporary Directories.1462hub # [ 9.305510] systemd[1]: Reached target Timer Units.1463hub # [ 9.309159] systemd[1]: Listening on D-Bus System Message Bus Socket.1464hub # [ 9.310871] systemd[1]: Listening on Nix Daemon Socket.1465hub # [ 9.313705] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1466hub # [ 9.317180] systemd[1]: Reached target Socket Units.1467hub # [ 9.319210] systemd[1]: Reached target Basic System.1468hub # [ 9.322323] systemd[1]: Started backdoor.service.1469hub # [ 9.332647] systemd[1]: Starting Import lastlog data into lastlog2 database...1470hub # [ 9.348923] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1471hub # [ 9.359948] systemd[1]: Starting Post-Boot Actions...1472hub # [ 9.384651] systemd[1]: Started Reset console on configuration changes.1473hub # [ 9.416115] systemd[1]: Starting resolvconf update...1474hub # connecting to host...1475hub # [ 9.475583] systemd[1]: Condition check resulted in Virtio network device being skipped.1476hub # [ 9.490793] systemd[1]: Finished Post-Boot Actions.1477hub # [ 9.501266] systemd[1]: Finished Firewall.1478hub: Guest shell says: b'Spawning backdoor root shell...\n'1479worker # [ 6.520916] systemd[1]: bpf-restrict-fs: LSM BPF program attached1480hub # [ 9.526290] nsncd[502]: Jul 13 09:51:31.461 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1481hub: connected to guest root shell1482hub # [ 9.535225] systemd[1]: Starting D-Bus System Message Bus...1483hub: (connecting took 7.24 seconds)1484hub # [ 9.539098] systemd[1]: Started Name Service Cache Daemon (nsncd).1485hub: (finished: waiting for the VM to finish booting, in 7.24 seconds)1486hub # [ 9.543953] systemd[1]: Reached target Host and Network Name Lookups.1487hub # [ 9.546898] systemd[1]: Reached target User and Group Name Lookups.1488hub # [ 9.573826] systemd[1]: Starting User Login Management...1489hub # [ 9.579670] systemd[1]: Finished Import lastlog data into lastlog2 database.1490worker # [ 6.642205] systemd[1]: Applying preset policy.1491hub # [ 9.741768] dbus-broker-launch[534]: Looking up NSS user entry for 'systemd-timesync'...1492hub # [ 9.746944] systemd[1]: Stopped target Host and Network Name Lookups.1493hub # [ 9.749753] systemd[1]: Stopping Host and Network Name Lookups...1494hub # [ 9.753250] systemd[1]: Stopped target User and Group Name Lookups.1495hub # [ 9.756294] systemd[1]: Stopping User and Group Name Lookups...1496hub # [ 9.759404] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1497hub # [ 9.762623] systemd[1]: nscd.service: Deactivated successfully.1498worker # [ 6.765505] systemd[1]: Populated /etc with preset unit settings.1499hub # [ 9.767594] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1500hub # [ 9.769711] dbus-broker-launch[534]: NSS returned no entry for 'systemd-timesync'1501hub # [ 9.774375] dbus-broker-launch[534]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1502hub # [ 9.796437] systemd-logind[539]: New seat seat0.1503hub # [ 9.799931] systemd[1]: Started User Login Management.1504hub # [ 9.813517] systemd[1]: Starting linger-users.service...1505hub # [ 9.827185] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1506hub # [ 9.828907] systemd[1]: Started D-Bus System Message Bus.1507worker # [ 6.863384] systemd[1]: initrd-switch-root.service: Deactivated successfully.1508worker # [ 6.865740] systemd[1]: Stopped initrd-switch-root.service.1509hub # [ 9.867482] dbus-broker-launch[534]: Ready1510worker # [ 6.870226] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1511worker # [ 6.873346] systemd[1]: Created slice Slice /system/getty.1512worker # [ 6.875434] systemd[1]: Created slice User and Session Slice.1513worker # [ 6.877024] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1514worker # [ 6.879068] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1515worker # [ 6.880905] systemd[1]: Expecting device /dev/hvc0...1516worker # [ 6.882215] systemd[1]: Expecting device /dev/ttyS0...1517worker # [ 6.883561] systemd[1]: Reached target Local Encrypted Volumes.1518worker # [ 6.885077] systemd[1]: Stopped target initrd-fs.target.1519worker # [ 6.886401] systemd[1]: Stopped target initrd-root-fs.target.1520worker # [ 6.887835] systemd[1]: Stopped target initrd-switch-root.target.1521worker # [ 6.889363] systemd[1]: Reached target Virtual Machines and Containers.1522worker # [ 6.890963] systemd[1]: Reached target Path Units.1523worker # [ 6.892216] systemd[1]: Reached target Remote File Systems.1524worker # [ 6.893631] systemd[1]: Reached target Slice Units.1525worker # [ 6.894975] systemd[1]: Reached target Swaps.1526worker # [ 6.897023] systemd[1]: Listening on Query the User Interactively for a Password.1527worker # [ 6.899752] systemd[1]: Listening on Process Core Dump Socket.1528worker # [ 6.901775] systemd[1]: Listening on Credential Encryption/Decryption.1529worker # [ 6.904151] systemd[1]: Listening on Factory Reset Management.1530worker # [ 6.905708] systemd[1]: Listening on Hostname Service Socket.1531worker # [ 6.909059] systemd[1]: Starting Journal Log Access Socket...1532worker # [ 6.910955] systemd[1]: Listening on Journal Audit Socket.1533worker # [ 6.914176] systemd[1]: Listening on Console Output Muting Service Socket.1534worker # [ 6.916080] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1535worker # [ 6.917951] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1536hub # [ 9.917698] systemd[1]: Started Name Service Cache Daemon (nsncd).1537worker # [ 6.920233] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1538worker # [ 6.923886] systemd[1]: Listening on Disk Repartitioning Service Socket.1539worker # [ 6.925615] systemd[1]: Listening on udev Control Socket.1540hub # [ 9.920936] nsncd[590]: Jul 13 09:51:31.859 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1541worker # [ 6.927159] systemd[1]: Listening on udev Varlink Socket.1542worker # [ 6.930421] systemd[1]: Mounting Huge Pages File System...1543hub # [ 9.928166] systemd[1]: linger-users.service: Deactivated successfully.1544hub # [ 9.932953] systemd[1]: Finished linger-users.service.1545worker # [ 6.936922] systemd[1]: Mounting POSIX Message Queue File System...1546hub # [ 10.182329] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31547worker # [ 6.943664] systemd[1]: Mounting Kernel Debug File System...1548hub # [ 9.937984] systemd[1]: Reached target Host and Network Name Lookups.1549hub # [ 9.943126] systemd[1]: Reached target User and Group Name Lookups.1550worker # [ 6.953961] systemd[1]: Mounting Kernel Trace File System...1551hub # [ 9.956723] systemd[1]: Finished resolvconf update.1552hub # [ 9.961397] systemd[1]: Reached target Preparation for Network.1553worker # [ 6.967969] systemd[1]: Starting Create List of Static Device Nodes...1554hub # [ 9.968261] systemd[1]: Starting DHCP Client...1555worker # [ 6.977932] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1556hub # [ 9.977755] systemd[1]: Starting Address configuration of eth1...1557hub # [ 9.985104] systemd[1]: Starting Extra networking commands....1558worker # [ 6.995274] systemd[1]: Starting Load Kernel Module configfs...1559worker # [ 6.998929] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1560hub # [ 9.998768] systemd[1]: Starting Tailscale node agent...1561worker # [ 7.002389] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1562worker # [ 7.005004] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1563worker # [ 7.012181] systemd[1]: Mounting FUSE Control File System...1564worker # [ 7.016169] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671565worker # [ 7.029399] systemd[1]: Starting Journal Service...1566worker # [ 7.036724] systemd[1]: Starting Load Kernel Modules...1567hub # [ 10.280237] ACPI: button: Power Button [PWRF]1568worker # [ 7.047915] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1569worker # [ 7.063064] systemd[1]: Starting Remount Root and Kernel File Systems...1570worker # [ 7.075774] loop: module loaded1571worker # [ 7.076773] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1572worker # [ 7.079646] systemd-journald[276]: Collecting audit messages is enabled.1573worker # [ 7.093141] systemd[1]: Starting Coldplug All udev Devices...1574hub # [ 10.332703] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1575worker # [ 7.122559] systemd[1]: Listening on Journal Log Access Socket.1576worker # [ 7.126838] EXT4-fs (vda): re-mounted 0e430e08-18d4-417f-b7e2-f6ddb956521c.1577worker # [ 7.132074] systemd[1]: Mounted Huge Pages File System.1578hub # [ 10.374368] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01579worker # [ 6.897890] systemd[1]: Queued start job for default target Multi-User System.[ 7.140582] systemd[1]: Started Journal Service.1580worker # 1581worker # [ 6.903750] systemd[1]: Unnecessary job was removed for /dev/vdb.1582worker # [ 6.907741] systemd[1]: systemd-journald.service: Deactivated successfully.1583worker # [ 6.911729] systemd-modules-load[277]: Inserted module 'loop'1584worker # [ 6.915566] systemd[1]: Mounted POSIX Message Queue File System.1585hub # [ 10.152667] network-addresses-eth1-start[615]: adding address 192.168.1.1/24... done1586hub # [ 10.402918] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1587worker # [ 6.925581] systemd[1]: Mounted Kernel Debug File System.1588worker # [ 6.927372] systemd[1]: Mounted Kernel Trace File System.1589worker # [ 6.929919] systemd[1]: Finished Create List of Static Device Nodes.1590worker # [ 6.933495] systemd[1]: modprobe@configfs.service: Deactivated successfully.1591worker # [ 6.938295] systemd[1]: Finished Load Kernel Module configfs.1592worker # [ 6.939834] systemd[1]: Mounted FUSE Control File System.1593hub # [ 10.423493] parport_pc 00:03: reported by Plug and Play ACPI1594worker # [ 6.945137] systemd[1]: Finished Load Kernel Modules.1595hub # [ 10.184941] network-addresses-eth1-start[615]: adding address 2001:db8:1::1/64... done1596worker # [ 6.950104] systemd[1]: Finished Remount Root and Kernel File Systems.1597worker # [ 6.967339] systemd-oomd[279]: No swap; memory pressure usage will be degraded1598worker # [ 6.975111] systemd[1]: Listening on Disk Image Download Service Socket.1599worker # [ 6.978204] systemd[1]: Mounting Kernel Configuration File System...1600hub # [ 10.457921] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1601worker # [ 6.986393] systemd[1]: Starting Firewall...1602hub # [ 10.470597] rtc_cmos 00:05: RTC can wake from S41603worker # [ 6.997112] systemd[1]: Starting Flush Journal to Persistent Storage...1604worker # [ 6.998824] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1605hub # [ 10.238373] systemd[1]: Finished Address configuration of eth1.1606hub # [ 10.488545] mousedev: PS/2 mouse device common for all mice1607worker # [ 7.010532] systemd[1]: Starting Load/Save OS Random Seed...1608worker # [ 7.025259] systemd[1]: Starting Apply Kernel Variables...1609worker # [ 7.044074] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1610worker # [ 7.045985] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1611worker # [ 7.048244] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1612hub # [ 10.533285] rtc_cmos 00:05: registered as rtc01613hub # [ 10.542506] Floppy drive(s): fd0 is 2.88M AMI BIOS1614worker # [ 7.304991] systemd-journald[276]: Received client request to flush runtime journal.1615hub # [ 10.336797] systemd[1]: Finished Extra networking commands..1616hub # [ 10.342172] systemd[1]: Reached target Network.1617hub # [ 10.354162] systemd[1]: Starting Nginx Web Server...1618hub # [ 10.368570] systemd[1]: Starting Permit User Sessions...1619hub # [ 10.388384] dhcpcd[634]: dhcpcd-10.3.2 starting1620hub # [ 10.410422] dhcpcd[682]: dev: loaded udev1621hub # [ 10.455411] systemd[1]: Finished Permit User Sessions.1622hub # [ 10.534466] tailscaled[617]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1623worker # [ 7.306435] systemd[1]: Mounted Kernel Configuration File System.1624worker # [ 7.312488] systemd[1]: Finished Load/Save OS Random Seed.1625worker # [ 7.314506] systemd[1]: Reached target First Boot Complete.1626worker # [ 7.320509] systemd[1]: Finished Apply Kernel Variables.1627worker # [ 7.323476] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1628worker # [ 7.329675] systemd[1]: Starting Create Static Device Nodes in /dev...1629worker # [ 7.331571] systemd[1]: Finished Create Static Device Nodes in /dev.1630worker # [ 7.337076] systemd[1]: Reached target Preparation for Local File Systems.1631worker # [ 7.338841] systemd[1]: Starting Rule-based Manager for Device Events and Files...1632hub # [ 10.575859] tailscaled[617]: logtail started1633worker # [ 7.342208] systemd[1]: Finished Flush Journal to Persistent Storage.1634hub # [ 10.579585] tailscaled[617]: 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"}1635hub # [ 10.585088] tailscaled[617]: LogID: 87ec7c3cff0d7188ad7cb6f75d0b786b6a5aabe30af9a87ed984b782cbe09fbb1636hub # [ 10.587883] tailscaled[617]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1637worker # [ 7.355325] systemd-udevd[315]: Using default interface naming scheme 'v261'.1638hub # [ 10.590252] tailscaled[617]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1639hub # [ 10.595255] tailscaled[617]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1640worker # [ 7.430127] systemd[1]: Started Rule-based Manager for Device Events and Files.1641hub # [ 10.665783] tailscaled[617]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:35282->[::1]:53: read: connection refused (in 26ms), trying bootstrap...1642hub # [ 10.687726] tailscaled[617]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...1643hub # [ 10.692348] tailscaled[617]: bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.74.153:443: connect: network is unreachable1644hub # [ 10.697364] tailscaled[617]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ...1645hub # [ 10.701642] tailscaled[617]: 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 unreachable1646hub # [ 10.710122] tailscaled[617]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ...1647hub # [ 10.712495] tailscaled[617]: bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 18.230.97.74:443: connect: network is unreachable1648hub # [ 10.717094] tailscaled[617]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ...1649worker # [ 7.488678] systemd[1]: Finished Coldplug All udev Devices.1650hub # [ 10.724071] tailscaled[617]: bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::f4]:443: connect: network is unreachable1651hub # [ 10.729221] tailscaled[617]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...1652hub # [ 10.733773] tailscaled[617]: 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 unreachable1653hub # [ 10.738877] tailscaled[617]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...1654hub # [ 10.742199] tailscaled[617]: bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2600:1f1e:ee4:5611:ec5c:1736:d43b:a454]:443: connect: network is unreachable1655hub # [ 10.754743] tailscaled[617]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ...1656hub # [ 10.762103] tailscaled[617]: 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 unreachable1657hub # [ 10.766620] tailscaled[617]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ...1658hub # [ 10.769240] tailscaled[617]: 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 unreachable1659hub # [ 10.775653] tailscaled[617]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ...1660hub # [ 10.779808] tailscaled[617]: 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 unreachable1661hub # [ 10.784321] tailscaled[617]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ...1662hub # [ 10.787090] tailscaled[617]: bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:1d9c:5400:2ff:feef:bb82]:443: connect: network is unreachable1663hub # [ 10.795315] tailscaled[617]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ...1664hub # [ 10.797746] tailscaled[617]: bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 103.43.75.49:443: connect: network is unreachable1665hub # [ 10.802189] tailscaled[617]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...1666hub # [ 10.804639] tailscaled[617]: 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 unreachable1667hub # [ 10.810846] tailscaled[617]: logtail: upload: log upload of 478 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/88ae78eee887394fa75cbc4503f353a131ba95d70a08f954196080203aafe87e": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1668hub # [ 10.562787] rtc_cmos 00:05: setting system clock to 2026-07-13T09:51:32 UTC (1783936292)1669hub # [ 10.562930] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1670hub # [ 10.587558] FDC 0 is a S82078B1671worker # [ 7.632877] systemd[1]: Mounting /run/wrappers...1672hub # [ 10.885689] nginx-pre-start[691]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok1673hub # [ 10.889332] nginx-pre-start[691]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful1674hub # [ 10.693669] 8021q: 802.1Q VLAN Support v1.81675hub # [ 10.693686] 8021q: adding VLAN 0 to HW filter on device eth11676worker # [ 7.663932] systemd[1]: Mounted /run/wrappers.1677worker # [ 7.667855] systemd[1]: Reached target Local File Systems.1678worker # [ 7.670266] systemd[1]: Listening on Boot Loader Control Service Socket.1679worker # [ 7.678152] systemd[1]: Starting register-nix-paths.service...1680hub # [ 10.997248] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41681hub # [ 11.075876] cfg80211: Loading compiled-in X.509 certificates for regulatory database1682worker # [ 7.685882] systemd[1]: Starting Create SUID/SGID Wrappers...1683worker # [ 7.687436] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1684worker # [ 7.706121] systemd[1]: Starting Save Transient machine-id to Disk...1685hub # [ 11.088702] Console: switching to colour dummy device 80x251686worker # [ 7.721875] systemd[1]: Starting Create System Files and Directories...1687hub # [ 11.118292] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1688hub # [ 11.118406] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1689hub # [ 10.970070] dhcpcd[682]: eth0: waiting for carrier1690hub # [ 10.972698] dhcpcd[682]: libudev: received NULL device1691hub # [ 10.974166] dhcpcd[682]: libudev: received NULL device1692hub # [ 10.976179] dhcpcd[682]: eth0: carrier acquired1693worker # [ 7.754244] systemd[1]: Finished Firewall.1694hub # [ 10.994128] dhcpcd[682]: DUID 00:01:00:01:31:e7:71:a5:52:54:00:12:34:561695hub # [ 10.996230] dhcpcd[682]: eth0: IAID 00:12:34:561696hub # [ 10.997882] dhcpcd[682]: eth0: adding address fe80::5054:ff:fe12:34561697hub # [ 11.120421] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21698hub # [ 11.120429] cfg80211: failed to load regulatory.db1699worker # [ 7.782397] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1700worker # [ 7.793374] systemd[1]: Finished Save Transient machine-id to Disk.1701hub # [ 11.168244] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61702hub # [ 11.168745] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51703hub # [ 11.068588] systemd-logind[539]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1704hub # [ 11.075697] systemd-logind[539]: Watching system buttons on /dev/input/event2 (Power Button)1705worker # [ 7.842396] systemd[1]: Finished Create System Files and Directories.1706hub # [ 11.211681] 8021q: adding VLAN 0 to HW filter on device eth01707hub # [ 11.314394] ppdev: user-space parallel port driver1708worker # [ 7.850217] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1709worker # [ 7.861121] systemd[1]: Starting Rebuild Journal Catalog...1710hub # [ 11.347290] [drm] Found bochs VGA, ID 0xb0c5.1711hub # [ 11.347300] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1712hub # [ 11.350841] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1713hub # [ 11.352188] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01714hub # [ 11.112314] systemd[1]: Started Getty on tty1.1715worker # [ 7.875966] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1716hub # [ 11.113618] systemd[1]: Reached target Login Prompts.1717hub # [ 11.119104] systemd[1]: Started Nginx Web Server.1718hub # [ 11.148073] dbus-broker-launch[534]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1719worker # [ 7.947385] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1720hub # [ 11.189349] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1721hub # [ 11.203109] systemd[1]: Starting Virtual Console Setup...1722hub # [ 11.211940] tailscaled[617]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1723hub # [ 11.213994] tailscaled[617]: dns: using "openresolv" mode1724hub # [ 11.225045] tailscaled[617]: dns: using dns.openresolvManager1725worker # [ 7.995166] systemd[1]: Finished Rebuild Journal Catalog.1726worker # [ 8.004460] systemd[1]: Starting Update is Completed...1727hub # [ 11.262345] dhcpcd[682]: eth0: soliciting a DHCP lease1728worker # [ 8.058646] systemd[1]: Finished Update is Completed.1729hub # [ 11.438103] fbcon: bochs-drmdrmfb (fb0) is primary device1730hub # [ 11.538424] Console: switching to colour frame buffer device 160x501731hub # [ 11.547317] NET: Registered PF_PACKET protocol family1732hub # [ 11.561115] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device1733hub # [ 11.313296] dhcpcd[682]: eth0: offered 10.0.2.15 from 10.0.2.21734hub # [ 11.324953] dhcpcd[682]: eth0: probing address 10.0.2.15/241735worker # [ 8.148973] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1736worker # [ 8.160530] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1737worker # [ 8.168342] systemd[1]: Finished Create SUID/SGID Wrappers.1738worker # [ 8.208488] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1739hub # [ 11.697797] kvm_amd: TSC scaling supported1740hub # [ 11.698836] kvm_amd: Nested Virtualization enabled1741hub # [ 11.700625] kvm_amd: Nested Paging enabled1742hub # [ 11.702415] kvm_amd: LBR virtualization supported1743hub # [ 11.704066] kvm_amd: Virtual VMLOAD VMSAVE supported1744hub # [ 11.705613] kvm_amd: Virtual GIF supported1745hub # [ 11.706863] kvm_amd: Virtual NMI enabled1746worker # [ 8.239127] (udev-worker)[401]: Network interface NamePolicy= disabled on kernel command line.1747worker # [ 8.254335] (udev-worker)[388]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1748worker # [ 8.260061] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line.1749worker # [ 8.337172] systemd[1]: Finished register-nix-paths.service.1750worker # [ 8.340376] systemd[1]: Reached target System Initialization.1751worker # [ 8.342721] systemd[1]: Started Discard unused filesystem blocks once a week.1752worker # [ 8.345361] systemd[1]: Started Daily Cleanup of Temporary Directories.1753hub # [ 11.825336] EDAC MC: Ver: 3.0.01754worker # [ 8.347249] systemd[1]: Reached target Timer Units.1755worker # [ 8.349603] systemd[1]: Listening on D-Bus System Message Bus Socket.1756worker # [ 8.351823] systemd[1]: Listening on Nix Daemon Socket.1757worker # [ 8.354282] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1758worker # [ 8.357253] systemd[1]: Listening on tribuchet-sandboxd.socket.1759worker # [ 8.360088] systemd[1]: Reached target Socket Units.1760worker # [ 8.361802] systemd[1]: Reached target Basic System.1761worker # [ 8.364732] systemd[1]: Started backdoor.service.1762worker # [ 8.375674] systemd[1]: Starting Import lastlog data into lastlog2 database...1763worker # [ 8.385762] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1764hub # [ 11.627521] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1765worker # [ 8.400922] systemd[1]: Starting Post-Boot Actions...1766worker # [ 8.416106] systemd[1]: Started Reset console on configuration changes.1767hub # [ 11.653517] systemd[1]: Started Tailscale node agent.1768hub # [ 11.658871] tailscaled[617]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1769worker # connecting to host...1770worker # [ 8.436112] systemd[1]: Starting resolvconf update...1771hub # [ 11.681643] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1772hub # [ 11.684970] systemd[1]: Stopped Virtual Console Setup.1773hub # [ 11.934654] tun: Universal TUN/TAP device driver, 1.61774hub # [ 11.699599] systemd[1]: Starting Virtual Console Setup...1775worker # [ 8.477267] systemd[1]: Finished Post-Boot Actions.1776hub # [ 11.730367] (udev-worker)[759]: Network interface NamePolicy= disabled on kernel command line.1777worker # [ 8.504466] nsncd[504]: Jul 13 09:51:33.682 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1778worker # [ 8.507963] systemd[1]: Condition check resulted in Virtio network device being skipped.1779worker # [ 8.511423] systemd[1]: Started Name Service Cache Daemon (nsncd).1780worker # [ 8.518304] systemd[1]: Finished Import lastlog data into lastlog2 database.1781worker # [ 8.522603] systemd[1]: Reached target Host and Network Name Lookups.1782worker # [ 8.526765] systemd[1]: Reached target User and Group Name Lookups.1783worker # [ 8.533815] systemd[1]: Starting D-Bus System Message Bus...1784hub # [ 11.773814] tailscaled[617]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1785hub # [ 11.776672] tailscaled[617]: dns: using "openresolv" mode1786hub # [ 11.784715] tailscaled[617]: dns: using dns.openresolvManager1787hub # [ 11.787124] tailscaled[617]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true}1788worker # [ 8.557183] systemd[1]: Starting User Login Management...1789hub # [ 11.796865] tailscaled[617]: magicsock: disco key = d:996761517a33a7451790hub # [ 11.799381] tailscaled[617]: Creating WireGuard device...1791hub # [ 11.802583] tailscaled[617]: Bringing WireGuard device up...1792hub # [ 11.805327] tailscaled[617]: Bringing router up...1793hub # [ 11.814063] tailscaled[617]: external route: up1794hub # [ 11.818382] tailscaled[617]: router: portUpdate(port=41641, network=udp6)1795hub # [ 11.820298] tailscaled[617]: router: using firewall mode pref1796hub # [ 11.846791] tailscaled[617]: router: default choosing iptables1797worker # [ 8.630839] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'...1798worker # [ 8.634280] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync'1799worker # [ 8.638361] 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"1800hub # [ 11.883402] tailscaled[617]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1801hub # [ 11.886249] tailscaled[617]: router: portUpdate(port=41641, network=udp4)1802worker # [ 8.652129] systemd[1]: Started D-Bus System Message Bus.1803hub # [ 11.891123] tailscaled[617]: Clearing router settings...1804hub # [ 11.892465] tailscaled[617]: Starting network monitor...1805hub # [ 11.895546] tailscaled[617]: Engine created.1806hub # [ 11.914840] tailscaled[617]: pm: migrating "_daemon" profile to new format1807worker # [ 8.680452] dbus-broker-launch[530]: Ready1808hub # [ 11.917121] tailscaled[617]: envknob: PORT="41641"1809hub # [ 11.923776] tailscaled[617]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1810hub # [ 11.927130] tailscaled[617]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1811hub # [ 11.931965] tailscaled[617]: got LocalBackend in 276ms1812hub # [ 11.933809] tailscaled[617]: Start1813worker # [ 8.698657] systemd[1]: Stopped target Host and Network Name Lookups.1814hub # [ 11.935166] tailscaled[617]: ipnext: "conn25": skipping extension1815worker # [ 8.700894] systemd[1]: Stopping Host and Network Name Lookups...1816hub # [ 11.937158] tailscaled[617]: ipnext: active extensions: conn25, portlist, posture, clientupdate, relayserver, taildrop1817worker # [ 8.703416] systemd[1]: Stopped target User and Group Name Lookups.1818worker # [ 8.707731] systemd[1]: Stopping User and Group Name Lookups...1819worker # [ 8.709347] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1820hub # [ 11.946817] tailscaled[617]: profile data directory: profile not found1821worker # [ 8.712593] systemd[1]: nscd.service: Deactivated successfully.1822hub # [ 11.950481] tailscaled[617]: Backend: logs: be:87ec7c3cff0d7188ad7cb6f75d0b786b6a5aabe30af9a87ed984b782cbe09fbb fe:1823worker # [ 8.715727] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1824worker # [ 8.717405] systemd[1]: nscd.service: Consumed 17ms CPU time over 321ms wall clock time, 6.8M memory peak, 5.5M read from disk.1825hub # [ 11.954386] tailscaled[617]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1826hub # [ 11.956874] tailscaled[617]: blockEngineUpdates(true)1827hub # [ 11.959891] tailscaled[617]: wgengine: Reconfig: configuring router1828hub # [ 11.961761] tailscaled[617]: wgengine: Reconfig: user dialer1829worker # [ 8.726465] systemd-logind[533]: New seat seat0.1830hub # [ 11.963820] tailscaled[617]: wgengine: Reconfig: configuring DNS1831hub # [ 11.965587] tailscaled[617]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1832worker # [ 8.730427] systemd[1]: Started User Login Management.1833hub # [ 11.968846] tailscaled[617]: health(warnable=wantrunning-false): error: Tailscale is stopped.1834hub # [ 11.971667] tailscaled[617]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1835hub # [ 11.973971] tailscaled[617]: dns: OScfg: {}1836worker # [ 8.748161] systemd[1]: Starting linger-users.service...1837worker # [ 8.763498] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1838worker # [ 8.797177] systemd[1]: Finished resolvconf update.1839worker # [ 8.804255] systemd[1]: Reached target Preparation for Network.1840worker # [ 8.815179] systemd[1]: Starting DHCP Client...1841worker # [ 8.825453] nsncd[577]: Jul 13 09:51:34.004 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1842worker # [ 8.832104] systemd[1]: Starting Address configuration of eth1...1843worker # [ 8.843200] systemd[1]: Starting Extra networking commands....1844worker # [ 8.856468] systemd[1]: Starting Tailscale node agent...1845worker # [ 8.868220] systemd[1]: Started Name Service Cache Daemon (nsncd).1846worker # [ 8.875841] systemd[1]: linger-users.service: Deactivated successfully.1847worker # [ 8.889901] systemd[1]: Finished linger-users.service.1848worker # [ 8.907119] systemd[1]: Reached target Host and Network Name Lookups.1849hub # [ 12.146884] systemd-vconsole-setup[771]: Configuration of first virtual console was skipped, ignoring remaining ones.1850worker # [ 8.912115] systemd[1]: Reached target User and Group Name Lookups.1851worker # [ 9.153838] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31852hub # [ 12.152310] systemd[1]: Finished Virtual Console Setup.1853worker # [ 8.945356] network-addresses-eth1-start[589]: adding address 192.168.1.2/24... done1854worker # [ 8.961558] network-addresses-eth1-start[589]: adding address 2001:db8:1::2/64... done1855worker # [ 8.981525] systemd[1]: Finished Address configuration of eth1.1856worker # [ 9.339982] ACPI: button: Power Button [PWRF]1857worker # [ 9.348854] mousedev: PS/2 mouse device common for all mice1858worker # [ 9.368310] rtc_cmos 00:05: RTC can wake from S41859worker # [ 9.145277] systemd[1]: Finished Extra networking commands..1860worker # [ 9.146792] systemd[1]: Reached target Network.1861worker # [ 9.157768] systemd[1]: Starting Permit User Sessions...1862worker # [ 9.166480] dhcpcd[626]: dhcpcd-10.3.2 starting1863worker # [ 9.175716] dhcpcd[665]: dev: loaded udev1864worker # [ 9.428925] 8021q: 802.1Q VLAN Support v1.81865worker # [ 9.437273] 8021q: adding VLAN 0 to HW filter on device eth11866worker # [ 9.214342] systemd[1]: Finished Permit User Sessions.1867worker # [ 9.226326] tailscaled[601]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1868worker # [ 9.229453] systemd[1]: Started Getty on tty1.1869worker # [ 9.234820] systemd[1]: Reached target Login Prompts.1870worker # [ 9.247230] tailscaled[601]: logtail started1871worker # [ 9.248520] 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"}1872worker # [ 9.253743] tailscaled[601]: LogID: bd0793bff602492de8a8bfab3853bdb077581bfcba38427527707d0e75f17e991873worker # [ 9.256414] tailscaled[601]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1874worker # [ 9.261987] tailscaled[601]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1875worker # [ 9.266826] tailscaled[601]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1876worker # [ 9.516991] parport_pc 00:03: reported by Plug and Play ACPI1877worker # [ 9.284222] tailscaled[601]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:50491->[::1]:53: read: connection refused (in 11ms), trying bootstrap...1878worker # [ 9.532916] rtc_cmos 00:05: registered as rtc01879worker # [ 9.296102] tailscaled[601]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ...1880worker # [ 9.301099] 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 unreachable1881worker # [ 9.305732] tailscaled[601]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ...1882worker # [ 9.308498] tailscaled[601]: 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 unreachable1883worker # [ 9.313813] tailscaled[601]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ...1884worker # [ 9.316256] tailscaled[601]: 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 unreachable1885worker # [ 9.559726] Floppy drive(s): fd0 is 2.88M AMI BIOS1886worker # [ 9.334316] tailscaled[601]: trying bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" ...1887worker # [ 9.340097] tailscaled[601]: bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:6001]:443: connect: network is unreachable1888worker # [ 9.345091] tailscaled[601]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ...1889worker # [ 9.347438] tailscaled[601]: bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.90.120:443: connect: network is unreachable1890worker # [ 9.351894] tailscaled[601]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ...1891worker # [ 9.357129] 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 unreachable1892worker # [ 9.362144] tailscaled[601]: trying bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" ...1893worker # [ 9.364558] tailscaled[601]: bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 208.111.34.178:443: connect: network is unreachable1894worker # [ 9.369132] tailscaled[601]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ...1895worker # [ 9.371859] tailscaled[601]: bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::29:9001]:443: connect: network is unreachable1896worker # [ 9.376726] tailscaled[601]: trying bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" ...1897worker # [ 9.379136] tailscaled[601]: bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.77.138:443: connect: network is unreachable1898worker # [ 9.383633] tailscaled[601]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ...1899worker # [ 9.389152] tailscaled[601]: bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5801:10b7:5400:2ff:feaa:284c]:443: connect: network is unreachable1900worker # [ 9.394530] tailscaled[601]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ...1901worker # [ 9.396869] tailscaled[601]: bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.90.120:443: connect: network is unreachable1902worker # [ 9.401310] tailscaled[601]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...1903worker # [ 9.404389] tailscaled[601]: bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2600:1f1e:ee4:5611:ec5c:1736:d43b:a454]:443: connect: network is unreachable1904worker # [ 9.409743] tailscaled[601]: logtail: upload: log upload of 475 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/48a9f6c8e6757d35e8c95d0d25adc73cadc67d63fc0c7b1f99757343bb19d064": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1905worker # [ 9.423254] dbus-broker-launch[530]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1906worker # [ 9.680948] rtc_cmos 00:05: setting system clock to 2026-07-13T09:51:34 UTC (1783936294)1907worker # [ 9.683684] systemd-journald[276]: Time jumped backwards, rotating.1908worker # [ 9.689222] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1909worker # [ 9.697172] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1910worker # [ 9.505522] tailscaled[601]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1911worker # [ 9.507599] tailscaled[601]: dns: using "openresolv" mode1912worker # [ 9.515683] tailscaled[601]: dns: using dns.openresolvManager1913worker # [ 9.789871] cfg80211: Loading compiled-in X.509 certificates for regulatory database1914worker # [ 9.802061] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1915worker # [ 9.803568] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1916worker # [ 9.812984] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21917worker # [ 9.816722] cfg80211: failed to load regulatory.db1918worker # [ 9.863163] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console1919worker # [ 9.868041] 8021q: adding VLAN 0 to HW filter on device eth01920worker # [ 9.634759] dhcpcd[665]: eth0: waiting for carrier1921hub # [ 12.868605] dhcpcd[682]: eth0: soliciting an IPv6 router1922worker # [ 9.637607] dhcpcd[665]: eth0: carrier acquired1923hub # [ 12.874525] dhcpcd[682]: eth0: Router Advertisement from fe80::21924hub # [ 12.879671] dhcpcd[682]: eth0: adding address fec0::5054:ff:fe12:3456/641925worker # [ 9.647837] dhcpcd[665]: DUID 00:01:00:01:31:e7:71:a6:52:54:00:12:34:561926worker # [ 9.649544] dhcpcd[665]: eth0: IAID 00:12:34:561927worker # [ 9.653206] dhcpcd[665]: eth0: adding address fe80::5054:ff:fe12:34561928hub # [ 12.885906] tailscaled[617]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2541929hub # [ 12.891591] tailscaled[617]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2541930hub # [ 12.896779] dhcpcd[682]: eth0: adding route to fec0::/641931hub # [ 12.900437] dhcpcd[682]: eth0: adding default route via fe80::21932worker # [ 9.674111] tailscaled[601]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1933worker # [ 9.677206] systemd[1]: Started Tailscale node agent.1934worker # [ 9.921296] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input41935worker # [ 9.925016] tun: Universal TUN/TAP device driver, 1.61936worker # [ 9.927602] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 01937hub # [ 12.915722] tailscaled[617]: 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::d27d:6781:9c8a:a064/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::d27d:6781:9c8a:a064/64] rebind-reason=[default-if-changed]1938hub # [ 12.934538] tailscaled[617]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1939hub # [ 12.938767] tailscaled[617]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1940hub # [ 12.940760] tailscaled[617]: dns: OScfg: {}1941worker # [ 9.714880] tailscaled[601]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1942worker # [ 9.717062] tailscaled[601]: dns: using "openresolv" mode1943worker # [ 9.725177] tailscaled[601]: dns: using dns.openresolvManager1944worker # [ 9.728676] tailscaled[601]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true}1945worker # [ 9.731434] tailscaled[601]: magicsock: disco key = d:9741b4a3ab39c0e51946worker # [ 9.733319] tailscaled[601]: Creating WireGuard device...1947worker # [ 9.735547] tailscaled[601]: Bringing WireGuard device up...1948worker # [ 9.743519] tailscaled[601]: Bringing router up...1949worker # [ 9.744790] tailscaled[601]: router: using firewall mode pref1950worker # [ 9.749103] tailscaled[601]: router: portUpdate(port=41641, network=udp6)1951worker # [ 9.751242] tailscaled[601]: external route: up1952hub # [ 12.992540] tailscaled[617]: wgengine: set DNS config again after major link change1953hub # [ 12.995224] tailscaled[617]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::d27d:6781:9c8a:a064/64]1954hub # [ 12.998428] tailscaled[617]: magicsock: 0 active derp conns1955hub # [ 13.001437] tailscaled[617]: router: portUpdate(port=41641, network=udp6)1956hub # [ 13.003087] tailscaled[617]: router: portUpdate(port=41641, network=udp4)1957worker # [ 9.778715] tailscaled[601]: router: default choosing iptables1958worker # [ 9.805391] tailscaled[601]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1959worker # [ 9.807750] tailscaled[601]: Clearing router settings...1960worker # [ 9.809162] tailscaled[601]: Starting network monitor...1961worker # [ 9.810482] tailscaled[601]: Engine created.1962worker # [ 9.813092] tailscaled[601]: router: portUpdate(port=41641, network=udp4)1963worker # [ 9.819623] tailscaled[601]: pm: migrating "_daemon" profile to new format1964worker # [ 9.821544] tailscaled[601]: envknob: PORT="41641"1965worker # [ 9.824093] tailscaled[601]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1966worker # [ 9.826289] tailscaled[601]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1967worker # [ 9.829793] tailscaled[601]: got LocalBackend in 157ms1968worker # [ 9.832211] tailscaled[601]: Start1969worker # [ 9.833515] tailscaled[601]: ipnext: "conn25": skipping extension1970worker # [ 9.835514] tailscaled[601]: ipnext: active extensions: portlist, posture, clientupdate, relayserver, taildrop, conn251971worker # [ 9.841386] tailscaled[601]: profile data directory: profile not found1972worker # [ 9.842978] tailscaled[601]: Backend: logs: be:bd0793bff602492de8a8bfab3853bdb077581bfcba38427527707d0e75f17e99 fe:1973worker # [ 9.845363] tailscaled[601]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1974worker # [ 9.848798] tailscaled[601]: blockEngineUpdates(true)1975worker # [ 9.851551] tailscaled[601]: wgengine: Reconfig: configuring router1976worker # [ 9.854501] tailscaled[601]: wgengine: Reconfig: user dialer1977worker # [ 9.858061] tailscaled[601]: health(warnable=wantrunning-false): error: Tailscale is stopped.1978worker # [ 9.859982] tailscaled[601]: wgengine: Reconfig: configuring DNS1979worker # [ 9.861509] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1980worker # [ 9.863498] tailscaled[601]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1981worker # [ 9.865444] tailscaled[601]: dns: OScfg: {}1982worker # [ 9.989487] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1983worker # [ 9.994399] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61984worker # [ 9.938211] systemd[1]: Starting Virtual Console Setup...1985worker # [ 10.009374] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51986worker # [ 10.021281] FDC 0 is a S82078B1987worker # [ 10.155132] Console: switching to colour dummy device 80x251988worker # [ 9.993048] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1989worker # [ 10.262841] [drm] Found bochs VGA, ID 0xb0c5.1990worker # [ 10.263647] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1991worker # [ 10.036691] systemd-logind[533]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1992worker # [ 10.056399] systemd-vconsole-setup[729]: Configuration of first virtual console was skipped, ignoring remaining ones.1993worker # [ 10.062901] systemd[1]: Finished Virtual Console Setup.1994worker # [ 10.308242] ppdev: user-space parallel port driver1995worker # [ 10.077608] systemd-logind[533]: Watching system buttons on /dev/input/event2 (Power Button)1996worker # [ 10.319750] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic1997worker # [ 10.332616] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 01998worker # [ 10.102198] (udev-worker)[399]: Network interface NamePolicy= disabled on kernel command line.1999worker # [ 10.148711] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2000worker # [ 10.151280] systemd[1]: Stopped Virtual Console Setup.2001worker # [ 10.154103] systemd[1]: Stopping Virtual Console Setup...2002worker # [ 10.158575] systemd[1]: Starting Virtual Console Setup...2003worker # [ 10.198500] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2004worker # [ 10.429840] fbcon: bochs-drmdrmfb (fb0) is primary device2005worker # [ 10.468674] Console: switching to colour frame buffer device 160x502006worker # [ 10.477818] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device2007worker # [ 10.211405] systemd-vconsole-setup[735]: Configuration of first virtual console was skipped, ignoring remaining ones.2008worker # [ 10.247647] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2009worker # [ 10.250260] systemd[1]: Stopped Virtual Console Setup.2010worker # [ 10.261135] systemd[1]: Starting Virtual Console Setup...2011worker # [ 10.307612] systemd-vconsole-setup[739]: Configuration of first virtual console was skipped, ignoring remaining ones.2012worker # [ 10.312806] systemd[1]: Finished Virtual Console Setup.2013worker # [ 10.577813] kvm_amd: TSC scaling supported2014worker # [ 10.578553] kvm_amd: Nested Virtualization enabled2015worker # [ 10.579804] kvm_amd: Nested Paging enabled2016worker # [ 10.580528] kvm_amd: LBR virtualization supported2017worker # [ 10.581688] kvm_amd: Virtual VMLOAD VMSAVE supported2018worker # [ 10.582826] kvm_amd: Virtual GIF supported2019worker # [ 10.583547] kvm_amd: Virtual NMI enabled2020worker # [ 10.625343] EDAC MC: Ver: 3.0.02021worker # [ 10.718961] dhcpcd[665]: eth0: soliciting a DHCP lease2022worker # [ 10.972566] NET: Registered PF_PACKET protocol family2023worker # [ 10.741964] dhcpcd[665]: eth0: offered 10.0.2.15 from 10.0.2.22024worker # [ 10.747421] dhcpcd[665]: eth0: probing address 10.0.2.15/242025hub # [ 14.073582] tailscaled[617]: monitor: RTM_NEWROUTE: src=, dst=fec0::d27d:6781:9c8a:a064/128, gw=, outif=2, table=2552026hub # [ 14.263194] tailscaled[617]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552027worker # [ 11.563954] dhcpcd[665]: eth0: soliciting an IPv6 router2028worker # [ 11.570116] dhcpcd[665]: eth0: Router Advertisement from fe80::22029worker # [ 11.573843] dhcpcd[665]: eth0: adding address fec0::5054:ff:fe12:3456/642030worker # [ 11.579133] dhcpcd[665]: eth0: adding route to fec0::/642031worker # [ 11.583476] dhcpcd[665]: eth0: adding default route via fe80::22032worker # [ 11.588967] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2542033worker # [ 11.594463] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2542034worker # [ 11.831629] 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::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed]2035worker # [ 11.856512] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2036worker # [ 11.863503] tailscaled[601]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2037worker # [ 11.868800] tailscaled[601]: dns: OScfg: {}2038worker # [ 11.892891] tailscaled[601]: wgengine: set DNS config again after major link change2039worker # [ 11.895837] tailscaled[601]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64]2040worker # [ 11.898930] tailscaled[601]: magicsock: 0 active derp conns2041worker # [ 11.901461] tailscaled[601]: router: portUpdate(port=41641, network=udp6)2042worker # [ 11.903618] tailscaled[601]: router: portUpdate(port=41641, network=udp4)2043worker # [ 13.108938] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552044worker # [ 13.300127] tailscaled[601]: monitor: RTM_NEWROUTE: src=, dst=fec0::3c11:2302:7c78:1b1a/128, gw=, outif=2, table=2552045hub # [ 16.700306] dhcpcd[682]: eth0: leased 10.0.2.15 for 86400 seconds2046hub # [ 16.703439] dhcpcd[682]: eth0: adding route to 10.0.2.0/242047hub # [ 16.706700] tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552048hub # [ 16.709593] tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552049hub # [ 16.712509] tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542050hub # [ 16.715230] tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542051hub # [ 16.717914] dhcpcd[682]: eth0: adding default route via 10.0.2.22052hub # [ 16.721723] tailscaled[617]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::d27d:6781:9c8a:a064/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::d27d:6781:9c8a:a064/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::d27d:6781:9c8a:a064/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::d27d:6781:9c8a:a064/64] rebind-reason=[ips-changed]2053hub # [ 16.751898] tailscaled[617]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2054hub # [ 16.753965] tailscaled[617]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2055hub # [ 16.756283] tailscaled[617]: dns: OScfg: {}2056hub # [ 16.854820] systemd[1]: Started DHCP Client.2057hub # [ 16.858521] systemd[1]: Reached target Network is Online.2058hub # [ 16.864287] systemd[1]: Started headscale coordination server for Tailscale.2059hub # [ 16.866912] systemd[1]: Reached target Multi-User System.2060hub # [ 16.868875] systemd[1]: Startup finished in 998ms (kernel) + 4.377s (initrd) + 11.492s (userspace) = 16.868s.2061hub # [ 17.223754] headscale-start[893]: 2026-07-13T09:51:39Z WRN2062hub # [ 17.225364] headscale-start[893]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed.2063hub # [ 17.236279] headscale-start[893]: 2026-07-13T09:51:39Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key2064hub # [ 17.241070] headscale-start[893]: 2026-07-13T09:51:39Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite2065hub # [ 17.345570] headscale-start[893]: 2026-07-13T09:51:39Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key2066hub # [ 17.355792] headscale-start[893]: 2026-07-13T09:51:39Z INF starting headscale commit=v0.29.2 version=0.29.22067hub # [ 17.358134] headscale-start[893]: 2026-07-13T09:51:39Z INF Clients with a lower minimum version will be rejected minimum_version=v1.802068hub # [ 17.361691] headscale-start[893]: 2026-07-13T09:51:39Z 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:[0x27d1e132120]}2069hub # [ 17.366654] headscale-start[893]: 2026-07-13T09:51:39Z 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}2070hub # [ 17.375612] headscale-start[893]: 2026-07-13T09:51:39Z INF HA subnet router health probing enabled interval=10000 timeout=50002071hub # [ 17.382663] headscale-start[893]: 2026-07-13T09:51:39Z INF stun server started at [::]:34782072hub # [ 17.396123] headscale-start[893]: 2026-07-13T09:51:39Z WRN listening without TLS but ServerURL does not start with http://2073hub # [ 17.399986] headscale-start[893]: 2026-07-13T09:51:39Z INF listening and serving HTTP on: 127.0.0.1:80802074hub # [ 17.402292] headscale-start[893]: 2026-07-13T09:51:39Z INF metrics server disabled (metrics_listen_addr is empty)2075hub # [ 17.838525] tailscaled[617]: wgengine: set DNS config again after major link change2076hub # [ 17.841422] tailscaled[617]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::d27d:6781:9c8a:a064/64]2077hub # [ 17.844564] tailscaled[617]: magicsock: 0 active derp conns2078hub: (finished: waiting for unit headscale, in 15.55 seconds)2079hub # [ 17.849212] tailscaled[617]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152080hub: waiting for TCP port 443 on localhost2081hub # [ 17.852798] tailscaled[617]: router: portUpdate(port=41641, network=udp6)2082hub # [ 17.857579] tailscaled[617]: router: portUpdate(port=41641, network=udp4)2083hub # [ 17.859691] tailscaled[617]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2084hub # Connection to localhost (::1) 443 port [tcp/https] succeeded!2085hub: (finished: waiting for TCP port 443 on localhost, in 0.07 seconds)2086hub: waiting for unit tailscaled2087hub: (finished: waiting for unit tailscaled, in 0.07 seconds)2088worker: waiting for unit tailscaled2089worker: waiting for the VM to finish booting2090worker: Guest shell says: b'Spawning backdoor root shell...\n'2091worker: connected to guest root shell2092worker: (connecting took 0.00 seconds)2093worker: (finished: waiting for the VM to finish booting, in 0.00 seconds)2094worker: (finished: waiting for unit tailscaled, in 0.04 seconds)2095hub: must succeed: headscale users create test2096hub # [ 18.119307] headscale-start[893]: 2026-07-13T09:51:40Z INF user created user.name=test2097hub: (finished: must succeed: headscale users create test, in 0.09 seconds)2098hub: must succeed: headscale preauthkeys -u 1 create --reusable2099hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.12 seconds)2100hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-miLlMqGe6H4l-6w6CagB56GhD7cw_HDTfihGH8E-wmo_Gc32wlM2-UV5Qc9ofMyOAal3AKfUmWirh --hostname hub2101hub # [ 18.315190] tailscaled[617]: localapi: [POST] /localapi/v0/check-prefs2102hub # [ 18.318207] tailscaled[617]: localapi: [POST] /localapi/v0/start2103hub # [ 18.320116] tailscaled[617]: Start2104hub # [ 18.322100] tailscaled[617]: 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]2105hub # [ 18.326289] tailscaled[617]: generating new machine key2106hub # [ 18.332240] tailscaled[617]: machine key written to store2107hub # [ 18.333955] tailscaled[617]: profile data directory: profile not found2108hub # [ 18.336990] tailscaled[617]: Backend: logs: be:87ec7c3cff0d7188ad7cb6f75d0b786b6a5aabe30af9a87ed984b782cbe09fbb fe:2109hub # [ 18.345817] tailscaled[617]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2110hub # [ 18.348435] tailscaled[617]: blockEngineUpdates(true)2111hub # [ 18.349699] tailscaled[617]: Reconfig(down): no changes made to Engine config2112hub # [ 18.352968] tailscaled[617]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2113hub # [ 18.355551] tailscaled[617]: health(warnable=wantrunning-false): ok2114hub # [ 18.357927] tailscaled[617]: control: client.Shutdown ...2115hub # [ 18.359318] tailscaled[617]: control: updateRoutine: exiting2116hub # [ 18.360735] tailscaled[617]: control: authRoutine: exiting2117hub # [ 18.362155] tailscaled[617]: control: mapRoutine: exiting2118hub # [ 18.364099] tailscaled[617]: control: Client.Shutdown done.2119hub # [ 18.365763] tailscaled[617]: localapi: [POST] /localapi/v0/login-interactive2120hub # [ 18.368100] tailscaled[617]: StartLoginInteractiveAs("root"): url=false2121hub # [ 18.370124] tailscaled[617]: control: client.Login(2)2122hub # [ 18.372953] tailscaled[617]: control: LoginInteractive -> regen=true2123hub # [ 18.374771] tailscaled[617]: control: doLogin(regen=true, hasUrl=false)2124hub # [ 18.447866] tailscaled[617]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2125hub # [ 18.464932] headscale-start[893]: 2026-07-13T09:51:40Z INF http request bytes=176 elapsed=3.239797 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:42342 status=2002126hub # [ 18.472101] tailscaled[617]: control: control server key from https://hub: ts2021=[288Sv], legacy=2127hub # [ 18.474778] tailscaled[617]: control: Generating a new nodekey.2128hub # [ 18.479545] tailscaled[617]: control: RegisterReq: onode= node=[Kd3oo] fup=false nks=false2129worker # [ 15.453627] dhcpcd[665]: eth0: leased 10.0.2.15 for 86400 seconds2130worker # [ 15.462355] dhcpcd[665]: eth0: adding route to 10.0.2.0/242131worker # [ 15.469891] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552132worker # [ 15.478374] dhcpcd[665]: eth0: adding default route via 10.0.2.22133worker # [ 15.482849] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552134worker # [ 15.495769] tailscaled[601]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed]2135worker # [ 15.524622] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2136worker # [ 15.528450] tailscaled[601]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2137worker # [ 15.530485] tailscaled[601]: dns: OScfg: {}2138worker # [ 15.531602] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542139worker # [ 15.533826] tailscaled[601]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542140worker # [ 15.589449] systemd[1]: Started DHCP Client.2141worker # [ 15.592795] systemd[1]: Reached target Multi-User System.2142worker # [ 15.594880] systemd[1]: Startup finished in 981ms (kernel) + 4.653s (initrd) + 9.959s (userspace) = 15.594s.2143hub # [ 19.359630] headscale-start[893]: 2026-07-13T09:51:41Z INF http request bytes=247 elapsed=859.065887 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:42354 status=2002144hub # [ 19.374860] tailscaled[617]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2145hub # [ 19.392715] tailscaled[617]: blockEngineUpdates(false)2146worker # [ 16.572859] tailscaled[601]: wgengine: set DNS config again after major link change2147worker # [ 16.581798] tailscaled[601]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::3c11:2302:7c78:1b1a/64 fec0::5054:ff:fe12:3456/64]2148worker # [ 16.590386] tailscaled[601]: magicsock: 0 active derp conns2149worker # [ 16.600897] tailscaled[601]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152150worker # [ 16.606515] tailscaled[601]: router: portUpdate(port=41641, network=udp6)2151worker # [ 16.611888] tailscaled[601]: router: portUpdate(port=41641, network=udp4)2152worker # [ 16.618143] tailscaled[601]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2153hub # [ 19.865913] headscale-start[893]: 2026-07-13T09:51:42Z INF http request bytes=0 elapsed=459.092427 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42354 status=2002154hub # [ 20.365836] headscale-start[893]: 2026-07-13T09:51:42Z INF node connected machine.key=[Bsbaa] node.expired=false node.id=1 node.is_tagged=false node.key=[Kd3oo] node.name=hub node.online=true user.name=test2155hub # [ 20.376518] headscale-start[893]: 2026-07-13T09:51:42Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x27d1df52700 component=poll machine.key=[Bsbaa] node.expired=false node.id=1 node.is_tagged=false node.key=[Kd3oo] node.name=hub node.online=false omit_peers=false stream=true user.name=test2156hub # [ 20.432801] tailscaled[617]: health(warnable=not-in-map-poll): ok2157hub # [ 20.447226] tailscaled[617]: active login: test2158hub # [ 20.457174] tailscaled[617]: netmap: suggested exit node: no preferred DERP, try again later2159hub # [ 20.459172] tailscaled[617]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2160hub # [ 20.462825] tailscaled[617]: magicsock: SetPrivateKey called (init)2161hub # [ 20.464777] tailscaled[617]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers)2162hub # [ 20.472338] tailscaled[617]: wgengine: Reconfig: configuring router2163hub # [ 20.706846] tailscaled[617]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [15ms] (forced=false)2164hub # [ 20.709406] tailscaled[617]: magicsock: home is now derp-999 ()2165hub # [ 20.712373] tailscaled[617]: 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::d27d:6781:9c8a:a064]:41641 (local)2166hub # [ 20.718213] tailscaled[617]: magicsock: adding connection to derp-999 for home-keep-alive2167hub # [ 20.720644] tailscaled[617]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2168hub # [ 20.723186] tailscaled[617]: derphttp.Client.Connect: connecting to derp-999 ()2169hub # [ 20.731335] tailscaled[617]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2170hub # [ 20.743653] tailscaled[617]: magicsock: derp-999 connected; connGen=12171hub # [ 20.989080] tailscaled[617]: router: enabling connmark-based rp_filter workaround2172hub # [ 21.084773] tailscaled[617]: wgengine: Reconfig: user dialer2173hub # [ 21.087109] tailscaled[617]: tsdial: bart table size: 22174hub # [ 21.088588] tailscaled[617]: wgengine: Reconfig: configuring DNS2175hub # [ 21.090493] tailscaled[617]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1}2176hub # [ 21.139123] tailscaled[617]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa}2177hub # [ 21.141510] tailscaled[617]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2178hub # [ 21.221617] systemd[1]: Stopped target Host and Network Name Lookups.2179hub # [ 21.223758] systemd[1]: Stopping Host and Network Name Lookups...2180hub # [ 21.226914] systemd[1]: Stopped target User and Group Name Lookups.2181hub # [ 21.228680] systemd[1]: Stopping User and Group Name Lookups...2182hub # [ 21.230886] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2183hub # [ 21.233662] systemd[1]: nscd.service: Deactivated successfully.2184hub # [ 21.236642] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2185hub # [ 21.251203] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2186hub # [ 21.282637] tailscaled[617]: peerapi: serving on http://100.64.0.1:584362187hub # [ 21.285708] tailscaled[617]: peerapi: serving on http://[fd7a:115c:a1e0::1]:597802188hub # [ 21.290859] tailscaled[617]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2189hub # [ 21.297781] tailscaled[617]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2190hub # [ 21.303505] systemd[1]: Started Name Service Cache Daemon (nsncd).2191hub # [ 21.305418] nsncd[1039]: Jul 13 09:51:43.483 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2192hub # [ 21.311802] systemd[1]: Reached target Host and Network Name Lookups.2193hub # [ 21.313418] systemd[1]: Reached target User and Group Name Lookups.2194hub # [ 21.316805] tailscaled[617]: netmap: suggested exit node: ()2195hub # [ 21.319169] tailscaled[617]: writing netmap to disk cache2196hub # [ 21.322282] tailscaled[617]: health(warnable=no-derp-connection): ok2197hub # [ 21.326863] tailscaled[617]: health(warnable=no-derp-connection): ok2198hub # [ 21.328404] tailscaled[617]: health(warnable=warming-up): ok2199hub # [ 21.329776] tailscaled[617]: [RATELIMIT] format("health(warnable=%s): ok")2200hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-miLlMqGe6H4l-6w6CagB56GhD7cw_HDTfihGH8E-wmo_Gc32wlM2-UV5Qc9ofMyOAal3AKfUmWirh --hostname hub, in 3.08 seconds)2201worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-miLlMqGe6H4l-6w6CagB56GhD7cw_HDTfihGH8E-wmo_Gc32wlM2-UV5Qc9ofMyOAal3AKfUmWirh --hostname tt-worker2202hub # [ 21.368949] headscale-start[893]: 2026-07-13T09:51:43Z INF http request bytes=0 elapsed=57.59028 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42354 status=2002203worker # [ 18.164267] tailscaled[601]: localapi: [POST] /localapi/v0/check-prefs2204worker # [ 18.166467] tailscaled[601]: localapi: [POST] /localapi/v0/start2205worker # [ 18.168222] tailscaled[601]: Start2206worker # [ 18.169843] 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]2207worker # [ 18.175217] tailscaled[601]: generating new machine key2208worker # [ 18.179682] tailscaled[601]: machine key written to store2209worker # [ 18.181411] tailscaled[601]: profile data directory: profile not found2210worker # [ 18.183653] tailscaled[601]: Backend: logs: be:bd0793bff602492de8a8bfab3853bdb077581bfcba38427527707d0e75f17e99 fe:2211worker # [ 18.186519] tailscaled[601]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2212worker # [ 18.189005] tailscaled[601]: blockEngineUpdates(true)2213worker # [ 18.190315] tailscaled[601]: Reconfig(down): no changes made to Engine config2214worker # [ 18.193584] tailscaled[601]: control: client.Shutdown ...2215worker # [ 18.194925] tailscaled[601]: control: mapRoutine: exiting2216worker # [ 18.196679] tailscaled[601]: localapi: [POST] /localapi/v0/login-interactive2217worker # [ 18.198963] tailscaled[601]: StartLoginInteractiveAs("root"): url=false2218worker # [ 18.200887] tailscaled[601]: control: client.Login(2)2219worker # [ 18.203780] tailscaled[601]: control: authRoutine: exiting2220worker # [ 18.207081] tailscaled[601]: control: LoginInteractive -> regen=true2221worker # [ 18.208882] tailscaled[601]: control: doLogin(regen=true, hasUrl=false)2222worker # [ 18.210781] tailscaled[601]: control: updateRoutine: exiting2223worker # [ 18.212595] tailscaled[601]: control: Client.Shutdown done.2224worker # [ 18.215962] tailscaled[601]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2225worker # [ 18.218919] tailscaled[601]: health(warnable=wantrunning-false): ok2226worker # [ 18.242099] tailscaled[601]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2227hub # [ 21.485409] headscale-start[893]: 2026-07-13T09:51:43Z INF http request bytes=176 elapsed=0.209524 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:42368 status=2002228worker # [ 18.259123] tailscaled[601]: control: control server key from https://hub: ts2021=[288Sv], legacy=2229worker # [ 18.261230] tailscaled[601]: control: Generating a new nodekey.2230worker # [ 18.263970] tailscaled[601]: control: RegisterReq: onode= node=[6pjdW] fup=false nks=false2231hub # [ 22.171840] tailscaled[617]: netmap: suggested exit node: ()2232worker # [ 19.138271] tailscaled[601]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2233hub # [ 22.372843] headscale-start[893]: 2026-07-13T09:51:44Z INF http request bytes=247 elapsed=852.159702 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:42378 status=2002234worker # [ 19.154243] tailscaled[601]: blockEngineUpdates(false)2235hub # [ 22.879969] headscale-start[893]: 2026-07-13T09:51:45Z INF http request bytes=0 elapsed=488.778881 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42378 status=2002236hub # [ 22.967433] tailscaled[617]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2237hub # [ 22.985176] tailscaled[617]: netmap: suggested exit node: ()2238hub # [ 22.995130] tailscaled[617]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2239hub # [ 23.000428] tailscaled[617]: wgengine: Reconfig: configuring router2240hub # [ 23.005418] tailscaled[617]: wgengine: Reconfig: user dialer2241hub # [ 23.008660] tailscaled[617]: tsdial: bart table size: 42242hub # [ 23.012901] tailscaled[617]: wgengine: Reconfig: configuring DNS2243hub # [ 23.016604] tailscaled[617]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2244hub # [ 23.078096] tailscaled[617]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2245hub # [ 23.080607] tailscaled[617]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2246hub # [ 23.139766] tailscaled[617]: netmap: suggested exit node: ()2247hub # [ 23.249646] tailscaled[617]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2248hub # [ 23.382734] headscale-start[893]: 2026-07-13T09:51:45Z INF http request bytes=0 elapsed=124.53594 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42354 status=2002249hub # [ 23.393130] headscale-start[893]: 2026-07-13T09:51:45Z INF node connected machine.key=[vdxto] node.expired=false node.id=2 node.is_tagged=false node.key=[6pjdW] node.name=tt-worker node.online=true user.name=test2250hub # [ 23.404325] headscale-start[893]: 2026-07-13T09:51:45Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0x27d1df1d810 component=poll machine.key=[vdxto] node.expired=false node.id=2 node.is_tagged=false node.key=[6pjdW] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test2251worker # [ 20.198824] tailscaled[601]: health(warnable=not-in-map-poll): ok2252worker # [ 20.223433] tailscaled[601]: active login: test2253worker # [ 20.244378] tailscaled[601]: netmap: suggested exit node: no preferred DERP, try again later2254worker # [ 20.249134] tailscaled[601]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2255worker # [ 20.254322] tailscaled[601]: magicsock: SetPrivateKey called (init)2256worker # [ 20.260305] tailscaled[601]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers)2257worker # [ 20.264334] tailscaled[601]: wgengine: Reconfig: configuring router2258worker # [ 20.375473] tailscaled[601]: router: enabling connmark-based rp_filter workaround2259worker # [ 20.399847] tailscaled[601]: wgengine: Reconfig: user dialer2260worker # [ 20.401330] tailscaled[601]: tsdial: bart table size: 42261worker # [ 20.402675] tailscaled[601]: wgengine: Reconfig: configuring DNS2262worker # [ 20.405150] tailscaled[601]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2}2263worker # [ 20.421098] tailscaled[601]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa}2264worker # [ 20.423578] tailscaled[601]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2265worker # [ 20.464836] systemd[1]: Stopped target Host and Network Name Lookups.2266worker # [ 20.467350] systemd[1]: Stopping Host and Network Name Lookups...2267worker # [ 20.470398] systemd[1]: Stopped target User and Group Name Lookups.2268worker # [ 20.472183] systemd[1]: Stopping User and Group Name Lookups...2269worker # [ 20.473729] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2270worker # [ 20.476262] systemd[1]: nscd.service: Deactivated successfully.2271worker # [ 20.477829] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2272worker # [ 20.489976] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2273worker # [ 20.493342] tailscaled[601]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [15ms] (forced=false)2274worker # [ 20.495604] tailscaled[601]: magicsock: home is now derp-999 ()2275worker # [ 20.501101] tailscaled[601]: magicsock: adding connection to derp-999 for home-keep-alive2276worker # [ 20.502980] tailscaled[601]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2277worker # [ 20.504752] tailscaled[601]: derphttp.Client.Connect: connecting to derp-999 ()2278worker # [ 20.512099] tailscaled[601]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::3c11:2302:7c78:1b1a]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local)2279worker # [ 20.522101] tailscaled[601]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2280hub # [ 23.761248] tailscaled[617]: netmap: suggested exit node: ()2281hub # [ 23.763098] tailscaled[617]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)")2282worker # [ 20.539215] systemd[1]: Started Name Service Cache Daemon (nsncd).2283worker # [ 20.540794] tailscaled[601]: magicsock: derp-999 connected; connGen=12284worker # [ 20.542650] nsncd[925]: Jul 13 09:51:45.595 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2285worker # [ 20.548761] systemd[1]: Reached target Host and Network Name Lookups.2286worker # [ 20.550398] systemd[1]: Reached target User and Group Name Lookups.2287worker # [ 20.553776] tailscaled[601]: peerapi: serving on http://100.64.0.2:465902288worker # [ 20.555803] tailscaled[601]: peerapi: serving on http://[fd7a:115c:a1e0::2]:471662289worker # [ 20.559101] tailscaled[601]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2290worker # [ 20.563451] tailscaled[601]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2291worker # [ 20.570112] tailscaled[601]: netmap: suggested exit node: ()2292worker # [ 20.571525] tailscaled[601]: writing netmap to disk cache2293worker # [ 20.573654] tailscaled[601]: health(warnable=no-derp-connection): ok2294worker # [ 20.575519] tailscaled[601]: health(warnable=no-derp-connection): ok2295worker # [ 20.577812] tailscaled[601]: health(warnable=no-derp-connection): ok2296worker # [ 20.579545] tailscaled[601]: [RATELIMIT] format("health(warnable=%s): ok")2297worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-miLlMqGe6H4l-6w6CagB56GhD7cw_HDTfihGH8E-wmo_Gc32wlM2-UV5Qc9ofMyOAal3AKfUmWirh --hostname tt-worker, in 2.49 seconds)2298worker: waiting for success: tailscale ping hub2299worker # [ 20.612488] tailscaled[601]: localapi: [POST] /localapi/v0/ping2300worker # [ 20.614431] tailscaled[601]: ping(100.64.0.1): sending disco ping to [Kd3oo] hub ...2301worker # [ 20.619986] tailscaled[601]: magicsock: disco: node [Kd3oo] d:996761517a33a745 now using 192.168.1.1:41641 mtu=1360 tx=b1a2f03505492302worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds)2303hub: must succeed: tailscale ip -42304hub # [ 23.881864] headscale-start[893]: 2026-07-13T09:51:46Z INF http request bytes=0 elapsed=60.400135 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42378 status=2002305hub: (finished: must succeed: tailscale ip -4, in 0.07 seconds)2306worker: 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.toml2307worker: (finished: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml, in 0.02 seconds)2308hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub2309hub # [ 23.986107] systemd[1]: Starting tribuchet-hub.socket...2310hub # [ 23.997211] systemd[1]: Listening on tribuchet-hub.socket.2311hub # [ 24.002692] systemd[1]: Starting tribuchet-hub.service...2312hub # [ 24.080257] tribuchet[1082]: 2026-07-13T09:51:46.258188Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[]2313hub # [ 24.086112] tribuchet[1082]: 2026-07-13T09:51:46.266032Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers2314hub # [ 24.091365] tribuchet[1082]: 2026-07-13T09:51:46.271077Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true2315hub # [ 24.099543] tribuchet[1082]: 2026-07-13T09:51:46.279394Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock2316hub # [ 24.104657] systemd[1]: Started tribuchet-hub.service.2317hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.16 seconds)2318worker: must succeed: systemctl start tribuchet-worker2319worker # [ 20.931726] systemd[1]: Starting tribuchet-worker.service...2320worker # [ 21.024315] exec[967]: 2026-07-13T09:51:46.081233Z 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 }2321worker # [ 21.035689] exec[967]: 2026-07-13T09:51:46.093274Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service2322worker # [ 21.043223] exec[970]: 2026-07-13T09:51:46.100669Z 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 }2323worker # [ 21.061099] exec[970]: 2026-07-13T09:51:46.116575Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox")2324worker # [ 21.066648] systemd[1]: Started tribuchet-worker.service.2325worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.20 seconds)2326hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"'2327hub # [ 24.338467] tailscaled[617]: magicsock: disco: node [6pjdW] d:9741b4a3ab39c0e5 now using [2001:db8:1::2]:41641 mtu=1360 tx=ac4e065666bb2328hub # [ 24.379376] headscale-start[893]: 2026-07-13T09:51:46Z INF http request bytes=0 elapsed=489.350462 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42378 status=2002329hub # [ 24.400198] tribuchet[1082]: 2026-07-13T09:51:46.580035Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }]2330hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 0.11 seconds)2331subtest: a build dispatches over the tailnet2332hub: must succeed: echo tailscale-auth-payload > /root/payload2333hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.02 seconds)2334hub: must succeed: nix-store --add /root/payload2335worker # [ 21.192445] exec[970]: 2026-07-13T09:51:46.249614Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"]2336hub: (finished: must succeed: nix-store --add /root/payload, in 0.13 seconds)2337hub: must succeed: cat > /root/test.nix << 'EOF'2338let2339 bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9";2340 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2341in derivation {2342 name = "tt-tailscale";2343 system = "x86_64-linux";2344 builder = bash + "/bin/bash";2345 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2346}2347EOF2348worker # [ 21.331800] tailscaled[601]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2349worker # [ 21.343727] tailscaled[601]: netmap: suggested exit node: ()2350worker # [ 21.350933] tailscaled[601]: netmap: suggested exit node: ()2351hub: (finished: must succeed: cat > /root/test.nix << 'EOF'2352let2353 bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9";2354 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2355in derivation {2356 name = "tt-tailscale";2357 system = "x86_64-linux";2358 builder = bash + "/bin/bash";2359 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2360}2361EOF, in 0.03 seconds)2362hub: must succeed: nix-build /root/test.nix --no-out-link2363hub # this derivation will be built:2364hub # /nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv2365hub # building '/nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv'...2366hub # [ 24.872918] tribuchet[1082]: 2026-07-13T09:51:47.053032Z INFO tribuchet::hub::submit: queueing build id="b3929f90fb2442a185ae6eb3c12dcf1b" system="x86_64-linux"2367hub # [ 24.877986] tribuchet[1082]: 2026-07-13T09:51:47.058148Z INFO tribuchet::hub: dispatching build id="b3929f90fb2442a185ae6eb3c12dcf1b" worker="tt-worker"2368hub # tribuchet: building on tt-worker2369worker # [ 21.650689] exec[970]: 2026-07-13T09:51:46.708155Z INFO tribuchet::worker: build assigned id="b3929f90fb2442a185ae6eb3c12dcf1b"2370worker # [ 21.672117] systemd[1]: Started Nix Daemon.2371worker # [ 21.732584] nix-daemon[972]: accepted connection from pid 970, user tribuchet (trusted)2372worker # [ 21.739449] exec[970]: 2026-07-13T09:51:46.797207Z 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={}2373worker # [ 21.745335] exec[970]: 2026-07-13T09:51:46.802900Z INFO harmonia_store_remote::client: Nix Version "2.34.8" version="2.34.8"2374hub # [ 24.988090] tribuchet[1082]: 2026-07-13T09:51:47.167204Z INFO tribuchet::hub::relay: input path negotiation done id="b3929f90fb2442a185ae6eb3c12dcf1b" total=8 missing=12375hub # [ 25.012697] systemd[1]: Started Nix Daemon.2376hub # [ 25.136137] nix-daemon[1111]: accepted connection from pid 1082, user root (trusted)2377hub # [ 25.145954] tribuchet[1082]: 2026-07-13T09:51:47.325583Z 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={}2378hub # [ 25.151790] tribuchet[1082]: 2026-07-13T09:51:47.331690Z INFO harmonia_store_remote::client: Nix Version "2.34.8+2" version="2.34.8+2"2379worker # [ 21.989538] systemd[1]: Starting tribuchet-sandboxd.service...2380worker # [ 22.039683] systemd[1]: Started tribuchet-sandboxd.service.2381worker # [ 22.044180] tribuchet-sandboxd[978]: 2026-07-13T09:51:47.099563Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock2382worker # [ 22.047783] tribuchet-sandboxd[978]: 2026-07-13T09:51:47.100621Z INFO tribuchet_sandboxd: leased build="b3929f90fb2442a185ae6eb3c12dcf1b" base=1325400064 uid_count=12383worker # [ 22.052673] exec[970]: 2026-07-13T09:51:47.101137Z INFO tribuchet::worker::build: leased sandbox build_id="b3929f90fb2442a185ae6eb3c12dcf1b" pool_base=1325400064 uid_count=12384worker # [ 22.057883] exec[970]: 2026-07-13T09:51:47.101825Z INFO tribuchet::worker::build: sandbox network decision id="b3929f90fb2442a185ae6eb3c12dcf1b" fixed_output=false network=false net_isolation=false2385worker # [ 22.268638] exec[970]: 2026-07-13T09:51:47.326115Z INFO tribuchet::worker::build: builder finished id="b3929f90fb2442a185ae6eb3c12dcf1b" exit_code=02386worker # [ 22.288270] exec[970]: 2026-07-13T09:51:47.345373Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="b3929f90fb2442a185ae6eb3c12dcf1b"2387worker # [ 22.315342] exec[970]: 2026-07-13T09:51:47.373031Z INFO tribuchet::worker::resume: build result acknowledged id="b3929f90fb2442a185ae6eb3c12dcf1b"2388hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 0.99 seconds)2389hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale2390hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale, in 0.03 seconds)2391hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build'2392hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.03 seconds)2393worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished'2394worker # [ 22.446074] tribuchet-sandboxd[978]: 2026-07-13T09:51:47.503455Z INFO tribuchet_sandboxd: released build="b3929f90fb2442a185ae6eb3c12dcf1b" base=13254000642395worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.05 seconds)2396(finished: subtest: a build dispatches over the tailnet, in 1.28 seconds)2397subtest: a non-tailnet peer is rejected2398worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml2399worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.01 seconds)2400worker: must succeed: systemctl restart tribuchet-worker2401worker # [ 22.477220] exec[970]: 2026-07-13T09:51:47.533427Z INFO tribuchet::worker: handover requested; exiting2402worker # [ 22.480856] systemd[1]: Stopping tribuchet-worker.service...2403hub # [ 25.717936] tribuchet[1082]: 2026-07-13T09:51:47.898050Z INFO tribuchet::hub: worker disconnected worker="tt-worker"2404worker # [ 22.686556] systemd[1]: tribuchet-worker.service: Deactivated successfully.2405worker # [ 22.695646] systemd[1]: Stopped tribuchet-worker.service.2406worker # [ 22.699504] systemd[1]: tribuchet-worker.service: Consumed 87ms CPU time over 1.762s wall clock time, 18.7M memory peak, 14.3M read from disk, 4K written to disk, 3.8K incoming IP traffic, 2.1K outgoing IP traffic.2407worker # [ 22.726202] systemd[1]: Starting tribuchet-worker.service...2408worker # [ 22.780498] exec[1005]: 2026-07-13T09:51:47.838024Z 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 }2409worker # [ 22.792600] exec[1005]: 2026-07-13T09:51:47.850272Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service2410worker # [ 22.799276] exec[1008]: 2026-07-13T09:51:47.856060Z 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 }2411worker # [ 22.811553] exec[1008]: 2026-07-13T09:51:47.856514Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox")2412worker # [ 22.817259] systemd[1]: Started tribuchet-worker.service.2413worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.36 seconds)2414hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed'2415hub # [ 26.432910] tribuchet[1082]: 2026-07-13T09:51:48.612154Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:438642416worker # [ 23.209238] exec[1008]: 2026-07-13T09:51:48.266671Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2417worker # [ 23.219960] exec[1008]: 2026-07-13T09:51:48.266764Z INFO tribuchet::worker: reconnecting to hub in 1s2418hub # [ 26.862688] tailscaled[617]: magicsock: disco: node [6pjdW] d:9741b4a3ab39c0e5 now using 192.168.1.2:41641 mtu=1360 tx=d47072adfc032419hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.15 seconds)2420(finished: subtest: a non-tailnet peer is rejected, in 1.52 seconds)2421(finished: run the VM test script, in 28.35 seconds)2422test script finished in 28.44s2423cleanup2424kill QemuMachine (pid 47)2425hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14)2426kill QemuMachine (pid 48)2427worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14)2428(finished: cleanup, in 0.34 seconds)2429additionally exposed symbols:2430 hub, worker,2431 vlan1,2432 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