vm-test-run-tribuchet-tailscale
checks.x86_64-linux.nixos-test-tailscale
· build #289
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 hub, worker,8 vlan1,9 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_ssh10start all VMs11hub: starting vm12worker: starting vm13hub # Disk image does not exist, creating the virtualisation disk image...14hub # Formatting '/build/vm-state-hub/tmp.PfsOmI6vm8', fmt=raw size=107374182415hub # mke2fs 1.47.4 (6-Mar-2025)16hub # Discarding device blocks: 0/262144 done17hub # Creating filesystem with 262144 4k blocks and 65536 inodes18hub # Filesystem UUID: ca613f11-64d2-4e2a-a633-ecf598794f7a19hub # Superblock backups stored on blocks:20hub # 32768, 98304, 163840, 22937621hub # 22hub # Allocating group tables: 0/8 done23hub # Writing inode tables: 0/8 done24hub # Creating journal (8192 blocks): done25hub # Writing superblocks and filesystem accounting information: 0/8 done26hub # 27hub # Virtualisation disk image created.28hub: QEMU running (pid 47)29hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)30hub # 31hub # 32hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC730+7EF2C730 CA0033hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)...34hub # 35hub # 36hub # 37hub # 38hub # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC730 7EF2C730 CB0039hub # Press Ctrl-B to configure iPXE (PCI 00:08.0)...40hub # 41hub # 42hub # Booting from ROM...43hub # Probing EDD (edd=off to disable)... ok44hub # [ 0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 23 12:27:10 UTC 202645hub # [ 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/nbr9125msn90csg49rxlfs8fiwxq69y2-nixos-system-hub-test/init regInfo=/nix/store/3aif6jbji958z34g9l8dqvskv1jgr5zm-closure-info/registration console=ttyS0,115200n8 console=tty046hub # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees.47hub # [ 0.000000] BIOS-provided physical RAM map:48hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable49hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved50hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved51hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable52hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved53hub # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved54hub # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved55hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved56hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved57hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved58hub # [ 0.000000] NX (Execute Disable) protection: active59hub # [ 0.000000] APIC: Static calls initialized60hub # [ 0.000000] SMBIOS 2.8 present.61hub # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201462hub # [ 0.000000] DMI: Memory slots populated: 1/163hub # [ 0.000000] Hypervisor detected: KVM64hub # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x40000000065hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0066hub # [ 0.000001] kvm-clock: using sched offset of 3188485427 cycles67hub # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns68hub # [ 0.000007] tsc: Detected 3099.998 MHz processor69hub # [ 0.001567] last_pfn = 0x7ffd8 max_arch_pfn = 0x40000000070hub # [ 0.001601] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs71hub # [ 0.001604] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT72hub # [ 0.004303] found SMP MP-table at [mem 0x000f5450-0x000f545f]73hub # [ 0.004324] Using GB pages for direct mapping74hub # [ 0.005276] RAMDISK: [mem 0x7e36f000-0x7ffcffff]75hub # [ 0.005287] ACPI: Early table checksum verification disabled76hub # [ 0.005292] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )77hub # [ 0.005297] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)78hub # [ 0.005302] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)79hub # [ 0.005309] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)80hub # [ 0.005312] ACPI: FACS 0x000000007FFE0000 00004081hub # [ 0.005314] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)82hub # [ 0.005317] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)83hub # [ 0.005319] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)84hub # [ 0.005321] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)85hub # [ 0.005323] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d]86hub # [ 0.005325] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219]87hub # [ 0.005326] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]88hub # [ 0.005326] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385]89hub # [ 0.005327] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd]90hub # [ 0.005328] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9]91hub # [ 0.005329] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421]92hub # [ 0.005980] No NUMA configuration found93hub # [ 0.005981] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]94hub # [ 0.005985] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]95hub # [ 0.006088] Zone ranges:96hub # [ 0.006089] DMA [mem 0x0000000000001000-0x0000000000ffffff]97hub # [ 0.006091] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff]98hub # [ 0.006092] Normal empty99hub # [ 0.006093] Device empty100hub # [ 0.006094] Movable zone start for each node101hub # [ 0.006094] Early memory node ranges102hub # [ 0.006095] node 0: [mem 0x0000000000001000-0x000000000009efff]103hub # [ 0.006096] node 0: [mem 0x0000000000100000-0x000000007ffd7fff]104hub # [ 0.006097] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]105hub # [ 0.006125] On node 0, zone DMA: 1 pages in unavailable ranges106hub # [ 0.006977] On node 0, zone DMA: 97 pages in unavailable ranges107hub # [ 0.051280] On node 0, zone DMA32: 40 pages in unavailable ranges108hub # [ 0.052263] ACPI: PM-Timer IO Port: 0x608109hub # [ 0.052278] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])110hub # [ 0.052305] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23111hub # [ 0.052308] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)112hub # [ 0.052310] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)113hub # [ 0.052311] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)114hub # [ 0.052312] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)115hub # [ 0.052313] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)116hub # [ 0.052316] ACPI: Using ACPI (MADT) for SMP configuration information117hub # [ 0.052317] ACPI: HPET id: 0x8086a201 base: 0xfed00000118hub # [ 0.052323] TSC deadline timer available119hub # [ 0.052329] CPU topo: Max. logical packages: 1120hub # [ 0.052329] CPU topo: Max. logical dies: 1121hub # [ 0.052330] CPU topo: Max. dies per package: 1122hub # [ 0.052334] CPU topo: Max. threads per core: 1123hub # [ 0.052336] CPU topo: Num. cores per package: 1124hub # [ 0.052336] CPU topo: Num. threads per package: 1125hub # [ 0.052337] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs126hub # [ 0.052442] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()127hub # [ 0.052480] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]128hub # [ 0.052482] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]129hub # [ 0.052484] [mem 0xc0000000-0xfed1bfff] available for PCI devices130hub # [ 0.052485] Booting paravirtualized kernel on KVM131hub # [ 0.052489] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns132hub # [ 0.057536] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1133hub # [ 0.060216] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152134hub # [ 0.060273] kvm-guest: PV spinlocks disabled, single CPU135hub # [ 0.060275] 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/nbr9125msn90csg49rxlfs8fiwxq69y2-nixos-system-hub-test/init regInfo=/nix/store/3aif6jbji958z34g9l8dqvskv1jgr5zm-closure-info/registration console=ttyS0,115200n8 console=tty0136hub # [ 0.060405] Unknown kernel command line parameters "regInfo=/nix/store/3aif6jbji958z34g9l8dqvskv1jgr5zm-closure-info/registration", will be passed to user space.137hub # [ 0.060426] random: crng init done138hub # [ 0.060427] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes139hub # [ 0.062706] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)140hub # [ 0.063867] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)141hub # [ 0.063912] Fallback order for Node 0: 0142hub # [ 0.063917] Built 1 zonelists, mobility grouping on. Total pages: 524150143hub # [ 0.063918] Policy zone: DMA32144hub # [ 0.066647] mem auto-init: stack:all(zero), heap alloc:on, heap free:off145hub # [ 0.073816] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1146hub # [ 0.078896] allocated 4194304 bytes of page_ext147hub # [ 0.088565] ftrace: allocating 48731 entries in 192 pages148hub # [ 0.088571] ftrace: allocated 192 pages with 2 groups149hub # [ 0.089531] Dynamic Preempt: lazy150hub # [ 0.089708] rcu: Preemptible hierarchical RCU implementation.151hub # [ 0.089709] rcu: RCU event tracing is enabled.152hub # [ 0.089710] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.153hub # [ 0.089711] Trampoline variant of Tasks RCU enabled.154hub # [ 0.089711] Rude variant of Tasks RCU enabled.155hub # [ 0.089712] Tracing variant of Tasks RCU enabled.156hub # [ 0.089713] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.157hub # [ 0.089714] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1158hub # [ 0.089731] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.159hub # [ 0.089733] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.160hub # [ 0.089734] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.161hub # [ 0.095597] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16162hub # [ 0.095942] rcu: srcu_init: Setting srcu_struct sizes based on contention.163hub # [ 0.095950] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns164hub # [ 0.096071] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)165hub # [ 0.102753] Console: colour VGA+ 80x25166hub # [ 0.102759] printk: legacy console [tty0] enabled167hub # [ 0.145497] printk: legacy console [ttyS0] enabled168hub # [ 0.320672] ACPI: Core revision 20250807169hub # [ 0.322394] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns170hub # [ 0.325000] APIC: Switch to symmetric I/O mode setup171hub # [ 0.326780] x2apic enabled172hub # [ 0.328136] APIC: Switched APIC routing to: physical x2apic173hub # [ 0.331203] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1174hub # [ 0.333382] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns175hub # [ 0.336874] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998)176hub # [ 0.337851] x86/cpu: User Mode Instruction Prevention (UMIP) activated177hub # [ 0.337851] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127178hub # [ 0.337851] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0179hub # [ 0.337851] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto180hub # [ 0.337851] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl181hub # [ 0.337851] Spectre V2 : Mitigation: Retpolines182hub # [ 0.337851] RETBleed: Mitigation: untrained return thunk183hub # [ 0.337851] Speculative Return Stack Overflow: Mitigation: SMT disabled184hub # [ 0.337851] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization185hub # [ 0.337864] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT186hub # [ 0.338851] Spectre V2 : Enabling Speculation Barrier for firmware calls187hub # [ 0.338851] active return thunk: retbleed_return_thunk188hub # [ 0.338851] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier189hub # [ 0.338851] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'190hub # [ 0.338851] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'191hub # [ 0.338860] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'192hub # [ 0.340851] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256193hub # [ 0.341851] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.194hub # [ 0.354650] Freeing SMP alternatives memory: 44K195hub # [ 0.355851] pid_max: default: 32768 minimum: 301196hub # [ 0.356960] LSM: initializing lsm=capability,landlock,yama,bpf,ima197hub # [ 0.359057] landlock: Up and running.198hub # [ 0.359859] Yama: becoming mindful.199hub # [ 0.362363] LSM support for eBPF active200hub # [ 0.364096] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)201hub # [ 0.365919] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)202hub # [ 0.370851] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0)203hub # [ 0.373708] Performance Events: Fam17h+ core perfctr, AMD PMU driver.204hub # [ 0.374864] ... version: 0205hub # [ 0.376460] ... bit width: 48206hub # [ 0.377856] ... generic counters: 6207hub # [ 0.378856] ... generic bitmap: 000000000000003f208hub # [ 0.379856] ... fixed-purpose counters: 0209hub # [ 0.380856] ... fixed-purpose bitmap: 0000000000000000210hub # [ 0.381856] ... value mask: 0000ffffffffffff211hub # [ 0.382868] ... max period: 00007fffffffffff212hub # [ 0.383857] ... global_ctrl mask: 000000000000003f213hub # [ 0.385070] signal: max sigframe size: 1776214hub # [ 0.386044] rcu: Hierarchical SRCU implementation.215hub # [ 0.386861] rcu: Max phase no-delay instances is 400.216hub # [ 0.394219] smp: Bringing up secondary CPUs ...217hub # [ 0.395439] smp: Brought up 1 node, 1 CPU218hub # [ 0.396879] smpboot: Total of 1 processors activated (6199.99 BogoMIPS)219hub # [ 0.398316] Memory: 1971636K/2096600K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115488K reserved, 0K cma-reserved)220hub # [ 0.400491] devtmpfs: initialized221hub # [ 0.401942] x86/mm: Memory block size: 128MB222hub # [ 0.404796] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)223hub # [ 0.406030] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).224hub # [ 0.407041] pinctrl core: initialized pinctrl subsystem225hub # [ 0.408753] PM: RTC time: 18:03:52, date: 2026-08-30226hub # [ 0.415861] NET: Registered PF_NETLINK/PF_ROUTE protocol family227hub # [ 0.417988] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations228hub # [ 0.419924] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations229hub # [ 0.421267] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations230hub # [ 0.421891] audit: initializing netlink subsys (disabled)231hub # [ 0.423503] thermal_sys: Registered thermal governor 'fair_share'232hub # [ 0.423505] thermal_sys: Registered thermal governor 'bang_bang'233hub # [ 0.424866] audit: type=2000 audit(1788113032.702:1): state=initialized audit_enabled=0 res=1234hub # [ 0.426879] thermal_sys: Registered thermal governor 'step_wise'235hub # [ 0.426882] thermal_sys: Registered thermal governor 'user_space'236hub # [ 0.427861] thermal_sys: Registered thermal governor 'power_allocator'237hub # [ 0.428942] cpuidle: using governor menu238hub # [ 0.432627] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5239hub # [ 0.434691] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]240hub # [ 0.435865] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry241hub # [ 0.436890] PCI: Using configuration type 1 for base access242hub # [ 0.438311] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.243hub # [ 0.449993] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages244hub # [ 0.450862] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page245hub # [ 0.453877] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages246hub # [ 0.454856] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page247hub # [ 0.471099] ACPI: Added _OSI(Module Device)248hub # [ 0.471860] ACPI: Added _OSI(Processor Device)249hub # [ 0.477865] ACPI: Added _OSI(Processor Aggregator Device)250hub # [ 0.491384] ACPI: 1 ACPI AML tables successfully acquired and loaded251hub # [ 0.496498] ACPI: Interpreter enabled252hub # [ 0.496952] ACPI: PM: (supports S0 S3 S4 S5)253hub # [ 0.498876] ACPI: Using IOAPIC for interrupt routing254hub # [ 0.500056] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug255hub # [ 0.509864] PCI: Using E820 reservations for host bridge windows256hub # [ 0.511084] ACPI: Enabled 2 GPEs in block 00 to 3F257hub # [ 0.527889] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])258hub # [ 0.528875] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]259hub # [ 0.529978] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]260hub # [ 0.530991] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]261hub # [ 0.532588] PCI host bridge to bus 0000:00262hub # [ 0.533838] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]263hub # [ 0.534858] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]264hub # [ 0.535858] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]265hub # [ 0.536858] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]266hub # [ 0.537860] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]267hub # [ 0.538862] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]268hub # [ 0.539861] pci_bus 0000:00: root bus resource [bus 00-ff]269hub # [ 0.541116] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint270hub # [ 0.543066] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint271hub # [ 0.545953] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]272hub # [ 0.546882] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]273hub # [ 0.547915] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]274hub # [ 0.549181] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]275hub # [ 0.552400] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint276hub # [ 0.556878] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]277hub # [ 0.557871] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]278hub # [ 0.558958] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]279hub # [ 0.560942] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]280hub # [ 0.566055] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint281hub # [ 0.569915] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]282hub # [ 0.570898] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]283hub # [ 0.571963] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]284hub # [ 0.574156] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint285hub # [ 0.576922] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]286hub # [ 0.578882] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]287hub # [ 0.579924] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]288hub # [ 0.582739] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint289hub # [ 0.586890] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]290hub # [ 0.588879] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]291hub # [ 0.591043] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]292hub # [ 0.593595] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint293hub # [ 0.596878] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]294hub # [ 0.597883] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]295hub # [ 0.599054] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]296hub # [ 0.601962] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint297hub # [ 0.606897] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]298hub # [ 0.607915] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]299hub # [ 0.608961] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]300hub # [ 0.614753] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint301hub # [ 0.618890] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]302hub # [ 0.619879] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]303hub # [ 0.620907] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]304hub # [ 0.622873] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]305hub # [ 0.625872] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint306hub # [ 0.630898] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]307hub # [ 0.632917] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]308hub # [ 0.635077] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint309hub # [ 0.637885] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]310hub # [ 0.639882] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]311hub # [ 0.640923] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]312hub # [ 0.645107] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint313hub # [ 0.648882] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]314hub # [ 0.649873] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]315hub # [ 0.650910] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]316hub # [ 0.654240] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint317hub # [ 0.657879] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]318hub # [ 0.659458] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint319hub # [ 0.663473] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]320hub # [ 0.664443] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint321hub # [ 0.667917] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]322hub # [ 0.669856] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint323hub # [ 0.672870] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]324hub # [ 0.676142] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint325hub # [ 0.678925] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO326hub # [ 0.681748] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint327hub # [ 0.685031] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]328hub # [ 0.685869] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]329hub # [ 0.689054] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint330hub # [ 0.691916] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]331hub # [ 0.702893] ACPI: PCI: Interrupt link LNKA configured for IRQ 10332hub # [ 0.703984] ACPI: PCI: Interrupt link LNKB configured for IRQ 10333hub # [ 0.704983] ACPI: PCI: Interrupt link LNKC configured for IRQ 11334hub # [ 0.706105] ACPI: PCI: Interrupt link LNKD configured for IRQ 11335hub # [ 0.707986] ACPI: PCI: Interrupt link LNKE configured for IRQ 10336hub # [ 0.708992] ACPI: PCI: Interrupt link LNKF configured for IRQ 10337hub # [ 0.709994] ACPI: PCI: Interrupt link LNKG configured for IRQ 11338hub # [ 0.711535] ACPI: PCI: Interrupt link LNKH configured for IRQ 11339hub # [ 0.712920] ACPI: PCI: Interrupt link GSIA configured for IRQ 16340hub # [ 0.713873] ACPI: PCI: Interrupt link GSIB configured for IRQ 17341hub # [ 0.714873] ACPI: PCI: Interrupt link GSIC configured for IRQ 18342hub # [ 0.716119] ACPI: PCI: Interrupt link GSID configured for IRQ 19343hub # [ 0.716873] ACPI: PCI: Interrupt link GSIE configured for IRQ 20344hub # [ 0.718869] ACPI: PCI: Interrupt link GSIF configured for IRQ 21345hub # [ 0.719879] ACPI: PCI: Interrupt link GSIG configured for IRQ 22346hub # [ 0.721869] ACPI: PCI: Interrupt link GSIH configured for IRQ 23347hub # [ 0.725253] iommu: Default domain type: Translated348hub # [ 0.725864] iommu: DMA domain TLB invalidation policy: lazy mode349hub # [ 0.727191] ACPI: bus type USB registered350hub # [ 0.727924] usbcore: registered new interface driver usbfs351hub # [ 0.728874] usbcore: registered new interface driver hub352hub # [ 0.729875] usbcore: registered new device driver usb353hub # [ 0.732293] NetLabel: Initializing354hub # [ 0.732856] NetLabel: domain hash size = 128355hub # [ 0.734855] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO356hub # [ 0.735903] NetLabel: unlabeled traffic allowed by default357hub # [ 0.736870] PCI: Using ACPI for IRQ routing358hub # [ 0.858203] pci 0000:00:01.0: vgaarb: setting as boot VGA device359hub # [ 0.858851] pci 0000:00:01.0: vgaarb: bridge control possible360hub # [ 0.858851] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none361hub # [ 0.858856] vgaarb: loaded362hub # [ 0.859751] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0363hub # [ 0.860728] hpet0: 3 comparators, 64-bit 100.000000 MHz counter364hub # [ 0.865964] clocksource: Switched to clocksource kvm-clock365hub # [ 0.870255] VFS: Disk quotas dquot_6.6.0366hub # [ 0.871349] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)367hub # [ 0.873470] pnp: PnP ACPI init368hub # [ 0.874758] ACPI: IRQ 4 override to edge(!), high(!)369hub # [ 0.876208] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved370hub # [ 0.878566] pnp: PnP ACPI: found 6 devices371hub # [ 0.886533] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns372hub # [ 0.888765] clocksource: Switched to clocksource acpi_pm373hub # [ 0.890308] NET: Registered PF_INET protocol family374hub # [ 0.892133] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)375hub # [ 0.912661] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)376hub # [ 0.915258] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)377hub # [ 0.917286] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)378hub # [ 0.919585] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)379hub # [ 0.922146] TCP: Hash tables configured (established 16384 bind 16384)380hub # [ 0.923942] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)381hub # [ 0.926235] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)382hub # [ 0.927965] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)383hub # [ 0.929959] NET: Registered PF_UNIX/PF_LOCAL protocol family384hub # [ 0.931442] NET: Registered PF_XDP protocol family385hub # [ 0.932739] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]386hub # [ 0.934291] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]387hub # [ 0.935960] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]388hub # [ 0.937759] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]389hub # [ 0.939516] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]390hub # [ 0.941546] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]391hub # [ 0.943884] ACPI: \_SB_.GSIA: Enabled at IRQ 16392hub # [ 0.946323] ACPI: \_SB_.GSIB: Enabled at IRQ 17393hub # [ 0.948621] ACPI: \_SB_.GSIC: Enabled at IRQ 18394hub # [ 0.950787] ACPI: \_SB_.GSID: Enabled at IRQ 19395hub # [ 0.953032] PCI: CLS 0 bytes, default 64396hub # [ 0.954297] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns397hub # [ 0.956842] Trying to unpack rootfs image as initramfs...398hub # [ 1.004671] Initialise system trusted keyrings399hub # [ 1.008120] workingset: timestamp_bits=40 max_order=19 bucket_order=0400hub # [ 1.035857] Key type asymmetric registered401hub # [ 1.038950] Asymmetric key parser 'x509' registered402hub # [ 1.040304] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)403hub # [ 1.047114] io scheduler mq-deadline registered404hub # [ 1.048310] io scheduler kyber registered405hub # [ 1.052582] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled406hub # [ 1.058302] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A407hub # [ 1.064500] Linux agpgart interface v0.103408hub # [ 1.065776] ACPI: bus type drm_connector registered409hub # [ 1.069390] usbcore: registered new interface driver usbserial_generic410hub # [ 1.071009] usbserial: USB Serial support registered for generic411hub # [ 1.074945] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled412hub # [ 1.077096] drop_monitor: Initializing network drop monitor service413hub # [ 1.084107] NET: Registered PF_INET6 protocol family414hub # [ 1.088407] Segment Routing with IPv6415hub # [ 1.089491] In-situ OAM (IOAM) with IPv6416hub # [ 1.093394] IPI shorthand broadcast: enabled417hub # [ 1.101344] sched_clock: Marking stable (862028854, 238902408)->(2289558128, -1188626866)418hub # [ 1.109089] registered taskstats version 1419hub # [ 1.110628] Loading compiled-in X.509 certificates420hub # [ 1.124123] Demotion targets for Node 0: null421hub # [ 1.128004] Key type .fscrypt registered422hub # [ 1.129093] Key type fscrypt-provisioning registered423hub # [ 1.133081] ima: No TPM chip found, activating TPM-bypass!424hub # [ 1.134592] ima: Allocated hash algorithm: sha1425hub # [ 1.139065] ima: No architecture policies found426hub # [ 1.140446] PM: Magic number: 6:690:90427hub # [ 1.144658] RAS: Correctable Errors collector initialized.428hub # [ 1.158969] clk: Disabling unused clocks429hub # [ 1.160086] PM: genpd: Disabling unused power domains430hub # [ 1.439106] Freeing initrd memory: 29060K431hub # [ 1.445388] Freeing unused decrypted memory: 2028K432hub # [ 1.448633] Freeing unused kernel image (initmem) memory: 3644K433hub # [ 1.453447] Write protecting the kernel read-only data: 32768k434hub # [ 1.455970] Freeing unused kernel image (text/rodata gap) memory: 1216K435hub # [ 1.460283] Freeing unused kernel image (rodata/data gap) memory: 756K436hub # [ 1.523044] x86/mm: Checked W+X mappings: passed, no W+X pages found.437hub # [ 1.524780] Run /init as init process438hub # [ 1.536848] systemd[1]: Inserted module 'autofs4'439hub # [ 1.556192] fuse: init (API version 7.45)440hub # [ 1.563712] ACPI: \_SB_.GSIG: Enabled at IRQ 22441hub # [ 1.567321] ACPI: \_SB_.GSIH: Enabled at IRQ 23442hub # [ 1.571986] ACPI: \_SB_.GSIE: Enabled at IRQ 20443hub # [ 1.575476] ACPI: \_SB_.GSIF: Enabled at IRQ 21444hub # [ 1.635072] systemd[1]: Successfully made /usr/ read-only.445hub # [ 1.972642] systemd[1]: systemd 261.2 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)446hub # [ 1.987477] systemd[1]: Detected virtualization kvm.447hub # [ 1.990459] systemd[1]: Detected architecture x86-64.448hub # [ 1.993613] systemd[1]: Running in initrd.449hub # [ 1.998332] systemd[1]: Initializing machine ID from random generator.450hub # [ 2.001786] systemd[1]: Hostname set to <hub>.451hub # [ 2.331977] systemd[1]: bpf-restrict-fs: LSM BPF program attached452hub # [ 2.462625] systemd[1]: Queued start job for default target Initrd Default Target.453hub # [ 2.478305] systemd[1]: Created slice Slice /system/modprobe.454hub # [ 2.488045] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.455hub # [ 2.498057] systemd[1]: Expecting device /dev/disk/by-label/nixos...456hub # [ 2.502562] systemd[1]: Reached target Path Units.457hub # [ 2.509557] systemd[1]: Reached target Slice Units.458hub # [ 2.512364] systemd[1]: Reached target Swaps.459hub # [ 2.521107] systemd[1]: Reached target Timer Units.460hub # [ 2.523536] systemd[1]: Listening on D-Bus System Message Bus Socket.461hub # [ 2.551468] systemd[1]: Listening on Journal Socket (/dev/log).462hub # [ 2.615195] systemd[1]: Listening on Journal Sockets.463hub # [ 2.618551] systemd[1]: Listening on udev Control Socket.464hub # [ 2.624552] systemd[1]: Listening on udev Kernel Socket.465hub # [ 2.626682] systemd[1]: Reached target Socket Units.466hub # [ 2.713324] systemd[1]: Starting Create List of Static Device Nodes...467hub # [ 2.728570] systemd[1]: Starting Load Kernel Module 9pnet_virtio...468hub # [ 2.754713] systemd[1]: Starting Load Kernel Module configfs...469hub # [ 2.793307] systemd[1]: Starting Journal Service...470hub # [ 2.811703] systemd[1]: Starting Load Kernel Modules...471hub # [ 2.823085] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os472hub # [ 2.826739] netfs: FS-Cache loaded473hub # [ 2.835776] systemd[1]: Starting Coldplug All udev Devices...474hub # [ 2.850496] 9pnet: Installing 9P2000 support475hub # [ 2.863997] systemd[1]: Finished Create List of Static Device Nodes.476hub # [ 2.892831] systemd[1]: modprobe@configfs.service: Deactivated successfully.477hub # [ 2.906107] systemd-journald[68]: Collecting audit messages is disabled.478hub # [ 2.913874] systemd[1]: Finished Load Kernel Module configfs.479hub # [ 2.930937] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.480hub # [ 2.942071] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev481hub # [ 2.946535] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.482hub # [ 2.954987] systemd[1]: Finished Load Kernel Module 9pnet_virtio.483hub # [ 2.963805] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config484hub # [ 2.988392] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...485hub # [ 3.009068] systemd[1]: Finished Load Kernel Modules.486hub # [ 3.018154] systemd[1]: Starting Apply Kernel Variables...487hub # [ 3.043150] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.488hub # [ 3.056431] systemd[1]: Starting Create Static Device Nodes in /dev...489hub # [ 3.080120] systemd[1]: Finished Apply Kernel Variables.490hub # [ 3.104123] systemd[1]: Finished Create Static Device Nodes in /dev.491hub # [ 2.868591] systemd-modules-load[69]: Inserted module 'dm_mod'492hub # [ 2.871852] systemd-modules-load[69]: Inserted module 'virtio_balloon'[ 3.112343] systemd[1]: Started Journal Service.493hub # 494hub # [ 2.874994] systemd-modules-load[69]: Inserted module 'virtio_gpu'495hub # [ 2.889192] systemd[1]: Reached target Preparation for Local File Systems.496hub # [ 2.892757] systemd[1]: Reached target Local File Systems.497hub # [ 2.897055] systemd[1]: Starting Create System Files and Directories...498hub # [ 2.904782] systemd[1]: Starting Rule-based Manager for Device Events and Files...499hub # [ 2.941089] systemd[1]: Finished Create System Files and Directories.500hub # [ 2.965692] systemd[1]: Finished Coldplug All udev Devices.501hub # [ 2.970564] systemd-udevd[83]: Using default interface naming scheme 'v261'.502hub # [ 2.990831] systemd[1]: Started Rule-based Manager for Device Events and Files.503hub # [ 2.994331] systemd[1]: Reached target System Initialization.504hub # [ 2.995667] systemd[1]: Reached target Basic System.505hub # [ 3.564051] virtio_blk virtio5: 1/0/0 default/read/poll queues506hub # [ 3.595653] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12507hub # [ 3.605583] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)508hub # [ 3.618748] serio: i8042 KBD port at 0x60,0x64 irq 1509hub # [ 3.631129] ehci-pci 0000:00:1d.7: EHCI Host Controller510hub # [ 3.632446] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1511hub # [ 3.634779] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000512hub # [ 3.644313] serio: i8042 AUX port at 0x60,0x64 irq 12513hub # [ 3.645558] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00514hub # [ 3.647256] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18515hub # [ 3.649010] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1516hub # [ 3.654972] usb usb1: Product: EHCI Host Controller517hub # [ 3.656268] usb usb1: Manufacturer: Linux 6.18.46 ehci_hcd518hub # [ 3.658729] usb usb1: SerialNumber: 0000:00:1d.7519hub # [ 3.661362] hub 1-0:1.0: USB hub found520hub # [ 3.663514] hub 1-0:1.0: 6 ports detected521hub # [ 3.683147] uhci_hcd 0000:00:1d.0: UHCI Host Controller522hub # [ 3.684502] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2523hub # [ 3.712958] uhci_hcd 0000:00:1d.0: detected 2 ports524hub # [ 3.729406] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200525hub # [ 3.746581] SCSI subsystem initialized526hub # [ 3.765863] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18527hub # [ 3.813970] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1528hub # [ 3.600927] systemd[1]: Starting Virtual Console Setup...529hub # [ 3.852670] usb usb2: Product: UHCI Host Controller530hub # [ 3.865040] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0531hub # [ 3.635427] (udev-worker)[88]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.532hub # [ 3.652304] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.533hub # [ 3.899016] usb usb2: Manufacturer: Linux 6.18.46 uhci_hcd534hub # [ 3.665418] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.535hub # [ 3.907068] usb 1-1: new high-speed USB device number 2 using ehci-pci536hub # [ 3.682395] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.537hub # [ 3.691102] systemd[1]: Finished Virtual Console Setup.538hub # [ 3.933100] usb usb2: SerialNumber: 0000:00:1d.0539hub # [ 3.963191] hub 2-0:1.0: USB hub found540hub # [ 3.986086] hub 2-0:1.0: 2 ports detected541hub # [ 4.008290] uhci_hcd 0000:00:1d.1: UHCI Host Controller542hub # [ 4.009590] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3543hub # [ 4.028451] uhci_hcd 0000:00:1d.1: detected 2 ports544hub # [ 3.791907] systemd[1]: Found device /dev/disk/by-label/nixos.545hub # [ 3.793671] systemd[1]: Reached target Initrd Root Device.546hub # [ 4.033778] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220547hub # [ 3.798391] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...548hub # [ 4.042978] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18549hub # [ 4.044634] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1550hub # [ 4.055939] usb usb3: Product: UHCI Host Controller551hub # [ 4.064686] usb usb3: Manufacturer: Linux 6.18.46 uhci_hcd552hub # [ 4.066475] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00553hub # [ 4.068070] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10554hub # [ 4.072338] usb 1-1: Product: QEMU USB Tablet555hub # [ 4.073597] usb usb3: SerialNumber: 0000:00:1d.1556hub # [ 4.074744] usb 1-1: Manufacturer: QEMU557hub # [ 4.075715] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1558hub # [ 4.078635] hub 3-0:1.0: USB hub found559hub # [ 4.081159] hub 3-0:1.0: 2 ports detected560hub # [ 4.093079] uhci_hcd 0000:00:1d.2: UHCI Host Controller561hub # [ 4.096312] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4562hub # [ 4.101548] uhci_hcd 0000:00:1d.2: detected 2 ports563hub # [ 4.105778] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240564hub # [ 4.110833] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode565hub # [ 4.113107] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18566hub # [ 3.881154] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks567hub # [ 4.121718] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1568hub # [ 4.124604] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)569hub # [ 4.128901] ahci 0000:00:1f.2: flags: 64bit ncq only570hub # [ 4.130336] usb usb4: Product: UHCI Host Controller571hub # [ 4.132960] usb usb4: Manufacturer: Linux 6.18.46 uhci_hcd572hub # [ 4.135220] hid: raw HID events driver (C) Jiri Kosina573hub # [ 4.136696] usb usb4: SerialNumber: 0000:00:1d.2574hub # [ 4.141285] scsi host0: ahci575hub # [ 4.142171] hub 4-0:1.0: USB hub found576hub # [ 4.143844] scsi host1: ahci577hub # [ 4.146979] scsi host2: ahci578hub # [ 4.148687] hub 4-0:1.0: 2 ports detected579hub # [ 3.913503] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.580hub # [ 4.160352] scsi host3: ahci581hub # [ 4.163549] scsi host4: ahci582hub # [ 4.165670] scsi host5: ahci583hub # [ 4.166827] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1584hub # [ 4.172057] usbcore: registered new interface driver usbhid585hub # [ 4.179733] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1586hub # [ 4.181661] usbhid: USB HID core driver587hub # [ 4.190058] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1588hub # [ 4.200928] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1589hub # [ 4.202578] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1590hub # [ 4.220547] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2591hub # [ 4.249798] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1592hub # [ 4.252197] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0593hub # [ 4.568218] ata6: SATA link down (SStatus 0 SControl 300)594hub # [ 4.569703] ata2: SATA link down (SStatus 0 SControl 300)595hub # [ 4.571827] ata5: SATA link down (SStatus 0 SControl 300)596hub # [ 4.573786] ata4: SATA link down (SStatus 0 SControl 300)597hub # [ 4.577989] ata1: SATA link down (SStatus 0 SControl 300)598hub # [ 4.580913] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)599hub # [ 4.582244] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100600hub # [ 4.586225] ata3.00: applying bridge limits601hub # [ 4.590485] ata3.00: configured for UDMA/100602hub # [ 4.592621] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5603hub # [ 4.770002] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray604hub # [ 4.783847] cdrom: Uniform CD-ROM driver Revision: 3.20605hub # [ 4.736977] systemd[1]: Mounting /sysroot...606hub # [ 5.287102] EXT4-fs (vda): mounted filesystem ca613f11-64d2-4e2a-a633-ecf598794f7a r/w with ordered data mode. Quota mode: none.607hub # [ 5.060092] systemd[1]: Mounted /sysroot.608hub # [ 5.062137] systemd[1]: Reached target Initrd Root File System.609hub # [ 5.068217] systemd[1]: Mounting /sysroot/nix/.ro-store...610hub # [ 5.071874] systemd[1]: Mounting /sysroot/nix/.rw-store...611hub # [ 5.087767] systemd[1]: Mounting /sysroot/run...612hub # [ 5.107302] systemd[1]: Mounting /sysroot/tmp/shared...613hub # [ 5.127226] systemd[1]: Mounting /sysroot/tmp/xchg...614hub # [ 5.159769] systemd[1]: Starting Mountpoints Configured in the Real Root...615hub # [ 5.627743] 9p: Installing v9fs 9p2000 file system support616hub # [ 5.417310] systemd-sysroot-fstab-check[153]: /sysroot should be mounted in the initrd, will request daemon-reload.617hub # [ 5.430845] systemd[1]: Mounted /sysroot/nix/.rw-store.618hub # [ 5.438135] systemd[1]: Mounted /sysroot/nix/.ro-store.619hub # [ 5.440747] systemd[1]: Mounted /sysroot/run.620hub # [ 5.445993] systemd[1]: Mounted /sysroot/tmp/shared.621hub # [ 5.495983] systemd[1]: Mounted /sysroot/tmp/xchg.622hub # [ 5.519166] systemd[1]: Reload requested from client PID 153 ('systemd-sysroot') (unit initrd-parse-etc.service)...623hub # [ 5.529128] systemd[1]: Reloading...624hub # [ 5.863418] systemd[1]: Reloading finished in 330 ms.625hub # [ 5.889112] systemd-sysroot-fstab-check[153]: Requesting initrd-fs.target/start/replace...626hub # [ 5.901433] systemd-sysroot-fstab-check[153]: Requesting swap.target/start/replace...627hub # [ 5.918092] systemd[1]: Starting rw-sysroot-nix-store.service...628hub # [ 6.019729] systemd[1]: initrd-parse-etc.service: Deactivated successfully.629hub # [ 6.047172] systemd[1]: Finished Mountpoints Configured in the Real Root.630hub # [ 6.050065] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.631hub # [ 6.073235] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.632hub # [ 6.076638] systemd[1]: Finished rw-sysroot-nix-store.service.633hub # [ 6.079935] systemd[1]: Mounting /sysroot/nix/store...634hub # [ 6.112113] systemd[1]: Mounted /sysroot/nix/store.635hub # [ 6.113452] systemd[1]: Reached target Initrd File Systems.636hub # [ 6.120089] systemd[1]: Starting Find NixOS closure...637hub # [ 6.126796] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...638hub # [ 6.161874] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.639hub # [ 6.166042] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.640hub # [ 6.180332] systemd[1]: Finished Find NixOS closure.641hub # [ 6.182885] systemd[1]: Reached target Initrd Default Target.642hub # [ 6.190525] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...643hub # [ 6.213745] systemd[1]: Stopped target Initrd Default Target.644hub # [ 6.218187] systemd[1]: Stopped target Basic System.645hub # [ 6.219479] systemd[1]: Stopped target Initrd Root Device.646hub # [ 6.220938] systemd[1]: Stopped target Path Units.647hub # [ 6.222889] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.648hub # [ 6.224430] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.649hub # [ 6.226848] systemd[1]: Stopped target Slice Units.650hub # [ 6.227970] systemd[1]: Stopped target Socket Units.651hub # [ 6.230365] systemd[1]: Stopped target System Initialization.652hub # [ 6.233098] systemd[1]: Stopped target Swaps.653hub # [ 6.234194] systemd[1]: Stopped target Timer Units.654hub # [ 6.235341] systemd[1]: dbus.socket: Deactivated successfully.655hub # [ 6.237831] systemd[1]: Closed D-Bus System Message Bus Socket.656hub # [ 6.240311] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.657hub # [ 6.242161] systemd[1]: Stopped Find NixOS closure.658hub # [ 6.243846] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio659hub # [ 6.248115] systemd[1]: Starting rw-sysroot-nix-store.service...660hub # [ 6.251241] systemd[1]: systemd-sysctl.service: Deactivated successfully.661hub # [ 6.252798] systemd[1]: Stopped Apply Kernel Variables.662hub # [ 6.254892] systemd[1]: systemd-modules-load.service: Deactivated successfully.663hub # [ 6.257516] systemd[1]: Stopped Load Kernel Modules.664hub # [ 6.258745] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.665hub # [ 6.262225] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.666hub # [ 6.264764] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.667hub # [ 6.266750] systemd[1]: Stopped Create System Files and Directories.668hub # [ 6.270203] systemd[1]: Stopped target Local File Systems.669hub # [ 6.272670] systemd[1]: Stopped target Preparation for Local File Systems.670hub # [ 6.274246] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.671hub # [ 6.276440] systemd[1]: Stopped Coldplug All udev Devices.672hub # [ 6.280491] systemd[1]: Stopping Rule-based Manager for Device Events and Files...673hub # [ 6.283102] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.674hub # [ 6.285319] systemd[1]: Stopped Virtual Console Setup.675hub # [ 6.295089] systemd[1]: systemd-udevd.service: Deactivated successfully.676hub # [ 6.299199] systemd[1]: Stopped Rule-based Manager for Device Events and Files.677hub # [ 6.303350] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.678hub # [ 6.305657] systemd[1]: Finished rw-sysroot-nix-store.service.679hub # [ 6.310410] systemd[1]: initrd-cleanup.service: Deactivated successfully.680hub # [ 6.314097] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.681hub # [ 6.318101] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.682hub # [ 6.320304] systemd[1]: Closed udev Control Socket.683hub # [ 6.323161] systemd[1]: Starting Cleanup udev Database...684hub # [ 6.325266] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.685hub # [ 6.328228] systemd[1]: Stopped Create Static Device Nodes in /dev.686hub # [ 6.329803] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.687hub # [ 6.331997] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.688hub # [ 6.333538] systemd[1]: kmod-static-nodes.service: Deactivated successfully.689hub # [ 6.335270] systemd[1]: Stopped Create List of Static Device Nodes.690hub # [ 6.351797] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.691hub # [ 6.356259] systemd[1]: Finished Cleanup udev Database.692hub # [ 6.358100] systemd[1]: Reached target Switch Root.693hub # [ 6.359989] systemd[1]: Starting NixOS Activation...694hub # [ 7.215986] initrd-nixos-activation-start[198]: booting system configuration /nix/store/nbr9125msn90csg49rxlfs8fiwxq69y2-nixos-system-hub-test695hub # [ 7.309575] initrd-nixos-activation-start[198]: running activation script...696hub # [ 11.801526] initrd-nixos-activation-start[221]: setting up /etc...697hub # [ 13.076597] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.698hub # [ 13.080191] systemd[1]: Finished NixOS Activation.699hub # [ 13.084275] systemd[1]: Starting Switch Root...700hub # [ 13.121904] systemd[1]: Switching root.701hub # [ 13.556913] systemd-journald[68]: Received SIGTERM from PID 1 (systemd).702hub # [ 30.544365] NET: Registered PF_VSOCK protocol family703hub # [ 30.953981] systemd[1]: systemd 261.2 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)704hub # [ 30.960097] systemd[1]: Detected virtualization kvm.705hub # [ 30.961352] systemd[1]: Detected architecture x86-64.706hub # [ 30.964868] systemd[1]: Detected first boot.707hub # [ 30.970377] systemd[1]: Initializing machine ID from random generator.708hub # [ 39.203076] systemd[1]: bpf-restrict-fs: LSM BPF program attached709hub # [ 39.827411] systemd[1]: Applying preset policy.710hub # [ 42.591541] systemd[1]: Populated /etc with preset unit settings.711hub # [ 44.110918] systemd[1]: initrd-switch-root.service: Deactivated successfully.712hub # [ 44.113173] systemd[1]: Stopped initrd-switch-root.service.713hub # [ 44.123010] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.714hub # [ 44.128823] systemd[1]: Created slice Slice /system/getty.715hub # [ 44.131205] systemd[1]: Created slice User and Session Slice.716hub # [ 44.132630] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.717hub # [ 44.134535] systemd[1]: Started Forward Password Requests to Wall Directory Watch.718hub # [ 44.136167] systemd[1]: Expecting device /dev/hvc0...719hub # [ 44.137342] systemd[1]: Expecting device /dev/ttyS0...720hub # [ 44.138606] systemd[1]: Reached target Local Encrypted Volumes.721hub # [ 44.139960] systemd[1]: Stopped target initrd-fs.target.722hub # [ 44.141198] systemd[1]: Stopped target initrd-root-fs.target.723hub # [ 44.142572] systemd[1]: Stopped target initrd-switch-root.target.724hub # [ 44.144053] systemd[1]: Reached target Virtual Machines and Containers.725hub # [ 44.145599] systemd[1]: Reached target Path Units.726hub # [ 44.146828] systemd[1]: Reached target Remote File Systems.727hub # [ 44.148181] systemd[1]: Reached target Slice Units.728hub # [ 44.149484] systemd[1]: Reached target Swaps.729hub # [ 44.157850] systemd[1]: Listening on Query the User Interactively for a Password.730hub # [ 44.169129] systemd[1]: Listening on Process Core Dump Socket.731hub # [ 44.176093] systemd[1]: Listening on Credential Encryption/Decryption.732hub # [ 44.181333] systemd[1]: Listening on Factory Reset Management.733hub # [ 44.182842] systemd[1]: Listening on Hostname Service Socket.734hub # [ 44.189023] systemd[1]: Starting Journal Log Access Socket...735hub # [ 44.197050] systemd[1]: Listening on Journal Audit Socket.736hub # [ 44.201699] systemd[1]: Listening on Console Output Muting Service Socket.737hub # [ 44.203465] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.738hub # [ 44.206008] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os739hub # [ 44.207969] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki740hub # [ 44.232321] systemd[1]: Listening on Disk Repartitioning Service Socket.741hub # [ 44.233872] systemd[1]: Listening on udev Control Socket.742hub # [ 44.235466] systemd[1]: Listening on udev Varlink Socket.743hub # [ 44.244935] systemd[1]: Mounting Huge Pages File System...744hub # [ 44.249784] systemd[1]: Mounting POSIX Message Queue File System...745hub # [ 44.254551] systemd[1]: Mounting Kernel Debug File System...746hub # [ 44.270538] systemd[1]: Mounting Kernel Trace File System...747hub # [ 44.291644] systemd[1]: Starting Create List of Static Device Nodes...748hub # [ 44.296347] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio749hub # [ 44.311611] systemd[1]: Starting Load Kernel Module configfs...750hub # [ 44.313590] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm751hub # [ 44.317957] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore752hub # [ 44.323094] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse753hub # [ 44.335255] systemd[1]: Mounting FUSE Control File System...754hub # [ 44.348083] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67755hub # [ 44.409186] systemd[1]: Starting Journal Service...756hub # [ 44.431549] systemd[1]: Starting Load Kernel Modules...757hub # [ 44.623997] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...758hub # [ 44.648774] systemd[1]: Starting Remount Root and Kernel File Systems...759hub # [ 44.659567] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os760hub # [ 44.679565] systemd[1]: Starting Coldplug All udev Devices...761hub # [ 44.683459] systemd[1]: Listening on Journal Log Access Socket.762hub # [ 44.696607] systemd[1]: Finished Create List of Static Device Nodes.763hub # [ 44.729247] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...764hub # [ 44.806562] systemd[1]: modprobe@configfs.service: Deactivated successfully.765hub # [ 44.815623] systemd[1]: Finished Load Kernel Module configfs.766hub # [ 44.822703] systemd[1]: Mounted Huge Pages File System.767hub # [ 44.828532] systemd[1]: Mounted POSIX Message Queue File System.768hub # [ 44.842706] systemd[1]: Mounted Kernel Debug File System.769hub # [ 44.848735] systemd[1]: Mounted Kernel Trace File System.770hub # [ 44.874004] systemd[1]: Mounted FUSE Control File System.771hub # [ 45.046909] systemd-journald[291]: Collecting audit messages is enabled.772hub # [ 45.084741] systemd[1]: Mounting Kernel Configuration File System...773hub # [ 45.135811] EXT4-fs (vda): re-mounted ca613f11-64d2-4e2a-a633-ecf598794f7a.774hub # [ 45.394591] systemd[1]: Finished Remount Root and Kernel File Systems.775hub # [ 45.417062] systemd[1]: Listening on Disk Image Download Service Socket.776hub # [ 45.424662] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore777hub # [ 45.200062] systemd[1]: Queued start job for default target Multi-User System.778hub # [ 45.202667] systemd[1]: systemd-journald.service: Deactivated successfully.779hub # [ 45.453807] systemd[1]: Starting Load/Save OS Random Seed...780hub # [ 45.457003] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os781hub # [ 45.461981] systemd[1]: Started Journal Service.782hub # [ 45.490867] loop: module loaded783hub # [ 45.283301] systemd-modules-load[292]: Inserted module 'loop'784hub # [ 45.404096] systemd[1]: Starting Flush Journal to Persistent Storage...785hub # [ 45.497994] systemd[1]: Finished Coldplug All udev Devices.786hub # [ 45.727670] systemd-oomd[293]: No swap; memory pressure usage will be degraded787hub # [ 45.840491] systemd-modules-load[292]: Inserted module 'tls'788hub # [ 45.869678] systemd[1]: Finished Load Kernel Modules.789hub # [ 45.879838] systemd[1]: Starting Firewall...790hub # [ 45.895141] systemd[1]: Starting Apply Kernel Variables...791hub # [ 45.899696] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.792hub # [ 46.175772] systemd-journald[291]: Received client request to flush runtime journal.793hub # [ 46.079482] systemd[1]: Mounted Kernel Configuration File System.794hub # [ 46.081216] systemd[1]: Finished Load/Save OS Random Seed.795hub # [ 46.082392] systemd[1]: Reached target First Boot Complete.796hub # [ 46.083602] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.797hub # [ 46.086228] systemd[1]: Starting Create Static Device Nodes in /dev...798hub # [ 46.100100] systemd[1]: Finished Flush Journal to Persistent Storage.799hub # [ 46.150489] systemd[1]: Finished Apply Kernel Variables.800hub # [ 46.299080] systemd[1]: Finished Create Static Device Nodes in /dev.801hub # [ 46.305406] systemd[1]: Reached target Preparation for Local File Systems.802hub # [ 46.319528] systemd[1]: Starting Rule-based Manager for Device Events and Files...803hub # [ 46.863825] systemd-udevd[328]: Using default interface naming scheme 'v261'.804hub # [ 46.943666] systemd[1]: Mounting /run/wrappers...805hub # [ 47.209380] systemd[1]: Mounted /run/wrappers.806hub # [ 47.211289] systemd[1]: Reached target Local File Systems.807hub # [ 47.219958] systemd[1]: Listening on Boot Loader Control Service Socket.808hub # [ 47.224892] systemd[1]: Starting register-nix-paths.service...809hub # [ 47.232337] systemd[1]: Starting Create SUID/SGID Wrappers...810hub # [ 47.234094] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.811hub # [ 47.247252] systemd[1]: Starting Save Transient machine-id to Disk...812hub # [ 47.293685] systemd[1]: Starting Create System Files and Directories...813hub # [ 47.473418] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.814hub # [ 47.512637] systemd[1]: Finished Save Transient machine-id to Disk.815hub # [ 47.645394] systemd[1]: Finished Create System Files and Directories.816hub # [ 47.653126] systemd[1]: Starting Rebuild Journal Catalog...817hub # [ 47.660830] systemd[1]: Starting Record System Boot/Shutdown in UTMP...818hub # [ 47.735298] systemd[1]: Started Rule-based Manager for Device Events and Files.819hub # [ 47.874092] systemd[1]: Finished Record System Boot/Shutdown in UTMP.820hub # [ 47.951967] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse821hub # [ 48.030958] systemd[1]: Finished Rebuild Journal Catalog.822hub # [ 48.042698] systemd[1]: Starting Update is Completed...823hub # [ 48.580847] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.824hub # [ 48.590085] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.825hub # [ 48.829721] systemd[1]: Finished Update is Completed.826hub # [ 48.922782] (udev-worker)[383]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.827hub # [ 48.934349] (udev-worker)[383]: Network interface NamePolicy= disabled on kernel command line.828hub # [ 48.938807] (udev-worker)[377]: Network interface NamePolicy= disabled on kernel command line.829hub # [ 49.277794] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3830hub # [ 49.309280] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console831hub # [ 49.343454] mousedev: PS/2 mouse device common for all mice832hub # [ 49.351491] ACPI: button: Power Button [PWRF]833hub # [ 49.357947] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4834hub # [ 49.404211] Console: switching to colour dummy device 80x25835hub # [ 49.430558] [drm] Found bochs VGA, ID 0xb0c5.836hub # [ 49.431561] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.837hub # [ 49.465631] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic838hub # [ 49.475504] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0839hub # [ 49.297706] systemd[1]: Condition check resulted in Virtio network device being skipped.840hub # [ 49.304677] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore841hub # [ 49.311539] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.842hub # [ 49.313449] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67843hub # [ 49.317948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore844hub # [ 49.322562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os845hub # [ 49.325243] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os846hub # [ 49.569137] rtc_cmos 00:04: RTC can wake from S4847hub # [ 49.598971] rtc_cmos 00:04: registered as rtc0848hub # [ 49.605717] rtc_cmos 00:04: setting system clock to 2026-08-30T18:04:42 UTC (1788113082)849hub # [ 49.612165] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized850hub # [ 49.626778] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs851hub # [ 49.629659] parport_pc 00:02: reported by Plug and Play ACPI852hub # [ 49.672335] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]853hub # [ 49.941799] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt854hub # [ 49.941948] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD855hub # [ 49.955848] Console: switching to colour frame buffer device 160x50856hub # [ 49.965312] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6857hub # [ 49.965868] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5858hub # [ 49.972051] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device859hub # [ 49.761122] systemd[1]: Starting Virtual Console Setup...860hub # [ 50.246694] kvm_amd: TSC scaling supported861hub # [ 50.247289] kvm_amd: Nested Virtualization enabled862hub # [ 50.248471] kvm_amd: Nested Paging enabled863hub # [ 50.249042] kvm_amd: LBR virtualization supported864hub # [ 50.249972] kvm_amd: Virtual VMLOAD VMSAVE supported865hub # [ 50.252567] kvm_amd: Virtual GIF supported866hub # [ 50.332104] EDAC MC: Ver: 3.0.0867hub # [ 50.245118] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.868hub # [ 50.249190] systemd[1]: Stopped Virtual Console Setup.869hub # [ 50.270435] systemd[1]: Starting Virtual Console Setup...870hub # [ 50.314679] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.871hub # [ 50.318459] systemd[1]: Stopped Virtual Console Setup.872hub # [ 50.335473] systemd[1]: Starting Virtual Console Setup...873hub # [ 50.578319] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)874hub # [ 50.585600] ppdev: user-space parallel port driver875hub # [ 50.631416] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)876hub # [ 50.413308] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.877hub # [ 50.416340] systemd[1]: Finished Create SUID/SGID Wrappers.878hub # [ 51.179810] systemd[1]: Finished register-nix-paths.service.879hub # [ 51.457355] systemd-vconsole-setup[496]: Configuration of first virtual console was skipped, ignoring remaining ones.880hub # [ 51.463746] systemd[1]: Finished Virtual Console Setup.881hub # [ 51.466879] systemd[1]: Reached target System Initialization.882hub # [ 51.469422] systemd[1]: Started Discard unused filesystem blocks once a week.883hub # [ 51.471754] systemd[1]: Started Daily Cleanup of Temporary Directories.884hub # [ 51.474136] systemd[1]: Reached target Timer Units.885hub # [ 51.475950] systemd[1]: Listening on D-Bus System Message Bus Socket.886hub # [ 51.477920] systemd[1]: Listening on Nix Daemon Socket.887hub # [ 51.480395] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.888hub # [ 51.483206] systemd[1]: Reached target Socket Units.889hub # [ 51.484553] systemd[1]: Reached target Basic System.890hub # [ 51.487328] systemd[1]: Started backdoor.service.891hub # [ 51.492931] systemd[1]: Starting Import lastlog data into lastlog2 database...892hub # [ 51.502650] systemd[1]: Starting Name Service Cache Daemon (nsncd)...893hub # [ 51.515446] systemd[1]: Starting Post-Boot Actions...894hub # [ 51.530712] systemd[1]: Started Reset console on configuration changes.895hub # [ 51.548918] systemd[1]: Starting resolvconf update...896hub # [ 51.581113] systemd[1]: Finished Firewall.897hub # [ 51.631855] systemd[1]: Starting D-Bus System Message Bus...898hub # connecting to host...899hub # [ 51.674456] systemd[1]: Finished Post-Boot Actions.900hub # [ 51.700335] systemd[1]: Started Name Service Cache Daemon (nsncd).901hub # [ 51.703955] systemd[1]: Reached target Host and Network Name Lookups.902hub # [ 51.706535] systemd[1]: Reached target User and Group Name Lookups.903hub # [ 51.714098] nsncd[556]: Aug 30 18:04:44.831 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"904hub # [ 51.726167] systemd[1]: Starting User Login Management...905hub # [ 51.733318] systemd[1]: Finished Import lastlog data into lastlog2 database.906hub # [ 51.854678] systemd-logind[583]: New seat seat0.907hub # [ 51.860645] systemd-logind[583]: Watching system buttons on /dev/input/event2 (Power Button)908hub # [ 51.863508] systemd-logind[583]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)909hub # [ 51.869171] systemd-logind[583]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)910hub # [ 51.871233] systemd[1]: Started User Login Management.911hub # [ 51.881137] systemd[1]: Starting linger-users.service...912hub # [ 51.883572] dbus-broker-launch[567]: Looking up NSS user entry for 'systemd-timesync'...913hub # [ 51.919712] systemd[1]: Stopped target Host and Network Name Lookups.914hub # [ 51.923158] systemd[1]: Stopping Host and Network Name Lookups...915hub # [ 51.925883] systemd[1]: Stopped target User and Group Name Lookups.916hub # [ 51.928884] dbus-broker-launch[567]: NSS returned no entry for 'systemd-timesync'917hub # [ 51.931987] dbus-broker-launch[567]: Invalid user-name in /nix/store/mpl7fnsx4pb41r5f5wmhzpi71a757pc5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"918hub # [ 51.937281] systemd[1]: Stopping User and Group Name Lookups...919hub # [ 51.939275] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...920hub # [ 51.942767] systemd[1]: nscd.service: Deactivated successfully.921hub # [ 51.946145] systemd[1]: Stopped Name Service Cache Daemon (nsncd).922hub # [ 51.965407] systemd[1]: Starting Name Service Cache Daemon (nsncd)...923hub # [ 51.995495] systemd[1]: linger-users.service: Deactivated successfully.924hub # [ 51.997992] systemd[1]: Finished linger-users.service.925hub # [ 52.003527] systemd[1]: Started D-Bus System Message Bus.926hub # [ 52.043766] systemd[1]: Started Name Service Cache Daemon (nsncd).927hub # [ 52.045874] nsncd[632]: Aug 30 18:04:45.175 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"928hub # [ 52.050763] systemd[1]: Reached target Host and Network Name Lookups.929hub # [ 52.053486] systemd[1]: Reached target User and Group Name Lookups.930hub # [ 52.059535] dbus-broker-launch[567]: Ready931hub # [ 52.089327] systemd[1]: Finished resolvconf update.932hub # [ 52.092111] systemd[1]: Reached target Preparation for Network.933hub # [ 52.098245] systemd[1]: Starting DHCP Client...934hub # [ 52.101887] systemd[1]: Starting Address configuration of eth1...935hub # [ 52.107175] systemd[1]: Starting Extra networking commands....936hub # [ 52.123709] systemd[1]: Starting Tailscale node agent...937hub # [ 52.288642] network-addresses-eth1-start[658]: adding address 192.168.1.1/24... done938hub # [ 52.317133] network-addresses-eth1-start[658]: adding address 2001:db8:1::1/64... done939hub # [ 52.348721] systemd[1]: Finished Address configuration of eth1.940hub # [ 52.390757] dhcpcd[669]: dhcpcd-10.3.2 starting941hub # [ 52.411770] dhcpcd[723]: dev: loaded udev942hub # [ 52.468462] systemd[1]: Finished Extra networking commands..943hub # [ 52.473094] systemd[1]: Reached target Network.944hub # [ 52.479526] systemd[1]: Starting Nginx Web Server...945hub # [ 52.485654] systemd[1]: Starting Permit User Sessions...946hub # [ 52.740475] 8021q: 802.1Q VLAN Support v1.8947hub # [ 52.741282] 8021q: adding VLAN 0 to HW filter on device eth1948hub # [ 52.611144] systemd[1]: Finished Permit User Sessions.949hub # [ 52.625457] systemd[1]: Started Getty on tty1.950hub # [ 52.630790] systemd[1]: Reached target Login Prompts.951hub # [ 52.671904] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.952hub # [ 53.013857] cfg80211: Loading compiled-in X.509 certificates for regulatory database953hub # [ 53.121216] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'954hub # [ 53.122721] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'955hub # [ 53.133874] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2956hub # [ 53.139840] cfg80211: failed to load regulatory.db957hub # [ 53.366592] 8021q: adding VLAN 0 to HW filter on device eth0958hub # [ 53.131745] dhcpcd[723]: eth0: waiting for carrier959hub # [ 53.264551] dhcpcd[723]: eth0: carrier acquired960hub # [ 53.305881] dhcpcd[723]: DUID 00:01:00:01:32:27:2d:3e:52:54:00:12:34:56961hub # [ 53.307861] dhcpcd[723]: eth0: IAID 00:12:34:56962hub # [ 53.309216] dhcpcd[723]: eth0: adding address fe80::5054:ff:fe12:3456963hub # [ 53.338575] tailscaled[660]: TPM: error opening: stat /dev/tpmrm0: no such file or directory964hub # [ 53.352589] nginx-pre-start[740]: nginx: the configuration file /nix/store/k1bflm5srhmlm6ngn48yw7qdvzbhgndn-nginx.conf syntax is ok965hub # [ 53.356062] nginx-pre-start[740]: nginx: configuration file /nix/store/k1bflm5srhmlm6ngn48yw7qdvzbhgndn-nginx.conf test is successful966hub # [ 53.368095] systemd[1]: Started Nginx Web Server.967hub # [ 53.406989] tailscaled[660]: Program starting: v1.102.3, Go 1.26.7: []string{"/nix/store/lfqbsp1wh59izfbs39sf9yds7dp0jwdj-tailscale-1.102.3/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}968hub # [ 53.420828] tailscaled[660]: LogID: ffc315636e6a75cc80db01f889b2957b18459eb86077209d1b728a42152a19e9969hub # [ 53.422873] tailscaled[660]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"970hub # [ 53.424565] tailscaled[660]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory971hub # [ 53.427469] tailscaled[660]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil972hub # [ 53.452807] dbus-broker-launch[567]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.973hub # [ 53.493690] tailscaled[660]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]974hub # [ 53.497124] tailscaled[660]: dns: using "openresolv" mode975hub # [ 53.505291] tailscaled[660]: dns: using dns.openresolvManager976hub # [ 53.925424] tailscaled[660]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found977hub # [ 53.937539] systemd[1]: Started Tailscale node agent.978hub # [ 53.943159] tailscaled[660]: wgengine.NewUserspaceEngine(tun "tailscale0") ...979hub # [ 54.214740] tun: Universal TUN/TAP device driver, 1.6980hub # [ 53.987815] (udev-worker)[751]: Network interface NamePolicy= disabled on kernel command line.981hub # [ 54.060681] tailscaled[660]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]982hub # [ 54.063129] tailscaled[660]: dns: using "openresolv" mode983hub # [ 54.078411] tailscaled[660]: dns: using dns.openresolvManager984hub # [ 54.080347] tailscaled[660]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true}985hub # [ 54.092891] tailscaled[660]: magicsock: disco key = d:2e9d1052a7d56760986hub # [ 54.094826] tailscaled[660]: Creating WireGuard device...987hub # [ 54.100765] tailscaled[660]: router: portUpdate(port=41641, network=udp6)988hub # [ 54.103102] tailscaled[660]: router: using firewall mode pref989hub # [ 54.118968] tailscaled[660]: Bringing WireGuard device up...990hub # [ 54.122860] tailscaled[660]: Bringing router up...991hub # [ 54.132266] tailscaled[660]: external route: up992hub # [ 54.164579] tailscaled[660]: router: default choosing iptables993hub # [ 54.218457] tailscaled[660]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true994hub # [ 54.221227] tailscaled[660]: router: portUpdate(port=41641, network=udp4)995hub # [ 54.227321] tailscaled[660]: Clearing router settings...996hub # [ 54.229834] tailscaled[660]: Starting network monitor...997hub # [ 54.233535] tailscaled[660]: Engine created.998hub # [ 54.282378] tailscaled[660]: pm: migrating "_daemon" profile to new format999hub # [ 54.285715] tailscaled[660]: envknob: PORT="41641"1000hub # [ 54.296680] tailscaled[660]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1001hub # [ 54.299604] tailscaled[660]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1002hub # [ 54.307256] tailscaled[660]: got LocalBackend in 367ms1003hub # [ 54.308978] tailscaled[660]: Start1004hub # [ 54.311127] tailscaled[660]: ipnext: "conn25": skipping extension1005hub # [ 54.313866] tailscaled[660]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop1006hub # [ 54.329706] tailscaled[660]: profile data directory: profile not found1007hub # [ 54.334237] tailscaled[660]: Backend: logs: be:ffc315636e6a75cc80db01f889b2957b18459eb86077209d1b728a42152a19e9 fe:1008hub # [ 54.337557] tailscaled[660]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1009hub # [ 54.339889] tailscaled[660]: blockEngineUpdates(true)1010hub # [ 54.342214] tailscaled[660]: wgengine: Reconfig: configuring router1011hub # [ 54.343869] tailscaled[660]: wgengine: Reconfig: user dialer1012hub # [ 54.345201] tailscaled[660]: wgengine: Reconfig: configuring DNS1013hub # [ 54.347115] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1014hub # [ 54.349113] tailscaled[660]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1015hub # [ 54.351136] tailscaled[660]: dns: OScfg: {}1016hub # [ 54.366898] tailscaled[660]: health(warnable=wantrunning-false): error: Tailscale is stopped.1017hub # [ 55.072227] dhcpcd[723]: eth0: soliciting an IPv6 router1018hub # [ 55.075341] dhcpcd[723]: eth0: Router Advertisement from fe80::21019hub # [ 55.076774] dhcpcd[723]: eth0: adding address fec0::5054:ff:fe12:3456/641020hub # [ 55.078615] dhcpcd[723]: eth0: adding route to fec0::/641021hub # [ 55.079944] dhcpcd[723]: eth0: adding default route via fe80::21022hub # [ 55.097211] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2541023hub # [ 55.099457] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2541024hub # [ 55.125576] dhcpcd[723]: eth0: soliciting a DHCP lease1025hub # [ 55.420587] NET: Registered PF_PACKET protocol family1026hub # [ 55.216556] dhcpcd[723]: eth0: offered 10.0.2.15 from 10.0.2.21027hub # [ 55.226245] dhcpcd[723]: eth0: probing address 10.0.2.15/241028hub # [ 55.284069] tailscaled[660]: 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::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/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::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed]1029hub # [ 55.327357] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1030hub # [ 55.329519] tailscaled[660]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1031hub # [ 55.334618] tailscaled[660]: dns: OScfg: {}1032hub # [ 55.499760] tailscaled[660]: wgengine: set DNS config again after major link change1033hub # [ 55.503259] tailscaled[660]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/64]1034hub # [ 55.514064] tailscaled[660]: magicsock: 0 active derp conns1035hub # [ 55.524078] tailscaled[660]: router: portUpdate(port=41641, network=udp6)1036hub # [ 55.527949] tailscaled[660]: router: portUpdate(port=41641, network=udp4)1037hub # [ 55.539045] tailscaled[660]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:49628->[::1]:53: read: connection refused (in 70ms), trying bootstrap...1038hub # [ 55.568791] tailscaled[660]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ...1039hub # [ 55.573077] tailscaled[660]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable1040hub # [ 55.580207] tailscaled[660]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...1041hub # [ 56.130214] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=fec0::1e5:f170:95c9:828d/128, gw=, outif=2, table=2551042hub # [ 56.514164] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2551043hub # [ 58.582590] tailscaled[660]: bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1044hub # [ 58.587346] tailscaled[660]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ...1045hub # [ 58.590410] tailscaled[660]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable1046hub # [ 58.594582] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ...1047hub # [ 60.007206] dhcpcd[723]: eth0: leased 10.0.2.15 for 86400 seconds1048hub # [ 60.011374] dhcpcd[723]: eth0: adding route to 10.0.2.0/241049hub # [ 60.015741] dhcpcd[723]: eth0: adding default route via 10.0.2.21050hub # [ 60.018895] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2551051hub # [ 60.025444] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2551052hub # [ 60.031160] tailscaled[660]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/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::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/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::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed]1053hub # [ 60.087121] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1054hub # [ 60.089317] tailscaled[660]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1055hub # [ 60.091286] tailscaled[660]: dns: OScfg: {}1056hub # [ 60.092280] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2541057hub # [ 60.094330] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2541058hub # [ 60.456967] systemd[1]: Started DHCP Client.1059hub # [ 60.461402] systemd[1]: Reached target Network is Online.1060hub # [ 60.475234] systemd[1]: Started headscale coordination server for Tailscale.1061hub # [ 60.478242] systemd[1]: Reached target Multi-User System.1062hub # [ 60.479905] systemd[1]: Startup finished in 1.290s (kernel) + 28.936s (initrd) + 30.252s (userspace) = 1min 479ms.1063hub # [ 61.292418] tailscaled[660]: wgengine: set DNS config again after major link change1064hub # [ 61.296649] tailscaled[660]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::1e5:f170:95c9:828d/64 fec0::5054:ff:fe12:3456/64]1065hub # [ 61.301251] tailscaled[660]: magicsock: 0 active derp conns1066hub # [ 61.305931] tailscaled[660]: router: portUpdate(port=41641, network=udp6)1067hub # [ 61.308202] tailscaled[660]: router: portUpdate(port=41641, network=udp4)1068hub # [ 61.310156] tailscaled[660]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")1069hub # [ 61.312565] tailscaled[660]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.151070hub # [ 61.530847] headscale-start[877]: 2026-08-30T18:04:54Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key1071hub # [ 61.536838] headscale-start[877]: 2026-08-30T18:04:54Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite1072hub # [ 61.590811] tailscaled[660]: 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": context deadline exceeded1073hub # [ 61.595697] tailscaled[660]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ...1074hub # [ 61.598321] tailscaled[660]: bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 46.101.74.201:443: connect: network is unreachable1075hub # [ 61.602674] tailscaled[660]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ...1076hub # [ 64.607372] tailscaled[660]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1077hub # [ 64.613266] tailscaled[660]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ...1078hub # [ 64.616991] tailscaled[660]: 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 unreachable1079hub # [ 64.621237] tailscaled[660]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ...1080hub # [ 67.618178] tailscaled[660]: bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1081hub # [ 67.625360] tailscaled[660]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ...1082hub # [ 67.628994] tailscaled[660]: bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 104.248.8.210:443: connect: network is unreachable1083hub # [ 67.634284] tailscaled[660]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ...1084hub # [ 70.636261] tailscaled[660]: bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1085hub # [ 70.639748] tailscaled[660]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ...1086hub # [ 70.642210] tailscaled[660]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable1087hub # [ 70.645943] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ...1088hub # [ 71.632057] headscale-start[877]: 2026-08-30T18:05:04Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key1089hub # [ 71.672461] headscale-start[877]: 2026-08-30T18:05:04Z INF starting headscale commit=v0.29.3 version=0.29.31090hub # [ 71.674774] headscale-start[877]: 2026-08-30T18:05:04Z INF Clients with a lower minimum version will be rejected minimum_version=v1.801091hub # [ 71.692135] headscale-start[877]: 2026-08-30T18:05:04Z 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:[0x2bd27cc88120]}1092hub # [ 71.697339] headscale-start[877]: 2026-08-30T18:05:04Z 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}1093hub # [ 71.715545] headscale-start[877]: 2026-08-30T18:05:04Z INF stun server started at [::]:34781094hub # [ 71.719820] headscale-start[877]: 2026-08-30T18:05:04Z INF HA subnet router health probing enabled interval=10000 timeout=50001095hub # [ 71.741607] headscale-start[877]: 2026-08-30T18:05:04Z WRN listening without TLS but ServerURL does not start with http://1096hub # [ 71.747907] headscale-start[877]: 2026-08-30T18:05:04Z INF listening and serving HTTP on: 127.0.0.1:80801097hub # [ 71.750850] headscale-start[877]: 2026-08-30T18:05:04Z INF metrics server disabled (metrics_listen_addr is empty)1098hub # [ 73.650211] tailscaled[660]: 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": context deadline exceeded1099hub # [ 73.654285] tailscaled[660]: logtail: upload: log upload of 3121 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/78114f96319e3d9a78af39dee54fc29c3cd3d02f94c6efdfb8f98be4e27a636c": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1100hub # [ 117.766873] tailscaled[660]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on 10.0.2.3:53: read udp 10.0.2.15:44673->10.0.2.3:53: i/o timeout (in 10.004s), trying bootstrap...1101worker # Disk image does not exist, creating the virtualisation disk image...1102worker # Formatting '/build/vm-state-worker/tmp.JXMnSJlmJ0', fmt=raw size=10737418241103worker # mke2fs 1.47.4 (6-Mar-2025)1104worker # Discarding device blocks: 0/262144 done1105worker # Creating filesystem with 262144 4k blocks and 65536 inodes1106worker: QEMU running (pid 48)1107worker # Filesystem UUID: b7a37648-fe9e-4602-ac29-1c377ee82bd81108worker # Superblock backups stored on blocks:1109worker # 32768, 98304, 163840, 2293761110worker # 1111worker # Allocating group tables: 0/8 done1112worker # Writing inode tables: 0/8 done1113worker # Creating journal (8192 blocks): done1114worker # Writing superblocks and filesystem accounting information: 0/8 done1115worker # 1116worker # Virtualisation disk image created.1117worker # Creating Nix store image...1118worker # Created Nix store image.1119(finished: start all VMs, in 137.62 seconds)1120hub: waiting for unit headscale1121hub: waiting for the VM to finish booting1122hub: Guest shell says: b'Spawning backdoor root shell...\n'1123hub: connected to guest root shell1124hub: (connecting took 0.00 seconds)1125hub: (finished: waiting for the VM to finish booting, in 0.00 seconds)1126worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)1127worker # 1128worker # 1129worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC590+7EF2C590 CA001130hub: (finished: waiting for unit headscale, in 0.23 seconds)1131hub: waiting for TCP port 443 on localhost1132worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)...1133worker # 1134worker # 1135worker # 1136worker # 1137worker # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC590 7EF2C590 CB001138worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)...1139worker # 1140worker # 1141worker # Booting from ROM...1142hub # Connection to localhost (::1) 443 port [tcp/https] succeeded!1143hub: (finished: waiting for TCP port 443 on localhost, in 0.15 seconds)1144hub: waiting for unit tailscaled1145worker # Probing EDD (edd=off to disable)... ok1146hub: (finished: waiting for unit tailscaled, in 0.09 seconds)1147worker: waiting for unit tailscaled1148worker: waiting for the VM to finish booting1149worker # [ 0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 23 12:27:10 UTC 20261150worker # [ 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/j6lk78pska82akk1m713f61nnzkhq1wz-nixos-system-worker-test/init regInfo=/nix/store/mpzwiw4bqr8ybpllmvpi3bjc25rv2wf5-closure-info/registration console=ttyS0,115200n8 console=tty01151worker # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees.1152worker # [ 0.000000] BIOS-provided physical RAM map:1153worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable1154worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved1155worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved1156worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd4fff] usable1157worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd5000-0x000000007fffffff] reserved1158worker # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved1159worker # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved1160worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved1161worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved1162worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved1163worker # [ 0.000000] NX (Execute Disable) protection: active1164worker # [ 0.000000] APIC: Static calls initialized1165worker # [ 0.000000] SMBIOS 2.8 present.1166worker # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/20141167worker # [ 0.000000] DMI: Memory slots populated: 1/11168worker # [ 0.000000] Hypervisor detected: KVM1169worker # [ 0.000000] last_pfn = 0x7ffd5 max_arch_pfn = 0x4000000001170worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d001171worker # [ 0.000001] kvm-clock: using sched offset of 723610742 cycles1172worker # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1173worker # [ 0.000007] tsc: Detected 3099.998 MHz processor1174worker # [ 0.000967] last_pfn = 0x7ffd5 max_arch_pfn = 0x4000000001175worker # [ 0.001003] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs1176worker # [ 0.001007] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT1177worker # [ 0.003283] found SMP MP-table at [mem 0x000f5450-0x000f545f]1178worker # [ 0.003302] Using GB pages for direct mapping1179worker # [ 0.003439] RAMDISK: [mem 0x7e360000-0x7ffcffff]1180worker # [ 0.003448] ACPI: Early table checksum verification disabled1181worker # [ 0.003452] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )1182worker # [ 0.003457] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)1183worker # [ 0.003463] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)1184worker # [ 0.003472] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)1185worker # [ 0.003476] ACPI: FACS 0x000000007FFE0000 0000401186worker # [ 0.003479] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)1187worker # [ 0.003482] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)1188worker # [ 0.003485] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)1189worker # [ 0.003488] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)1190worker # [ 0.003491] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d]1191worker # [ 0.003492] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219]1192worker # [ 0.003493] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]1193worker # [ 0.003494] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385]1194worker # [ 0.003495] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd]1195worker # [ 0.003496] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9]1196worker # [ 0.003496] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421]1197worker # [ 0.003949] No NUMA configuration found1198worker # [ 0.003951] Faking a node at [mem 0x0000000000000000-0x000000007ffd4fff]1199worker # [ 0.003954] NODE_DATA(0) allocated [mem 0x7e35aa80-0x7e35ffff]1200worker # [ 0.004048] Zone ranges:1201worker # [ 0.004049] DMA [mem 0x0000000000001000-0x0000000000ffffff]1202worker # [ 0.004051] DMA32 [mem 0x0000000001000000-0x000000007ffd4fff]1203worker # [ 0.004052] Normal empty1204worker # [ 0.004053] Device empty1205worker # [ 0.004054] Movable zone start for each node1206worker # [ 0.004054] Early memory node ranges1207worker # [ 0.004055] node 0: [mem 0x0000000000001000-0x000000000009efff]1208worker # [ 0.004056] node 0: [mem 0x0000000000100000-0x000000007ffd4fff]1209worker # [ 0.004057] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd4fff]1210worker # [ 0.004078] On node 0, zone DMA: 1 pages in unavailable ranges1211worker # [ 0.004351] On node 0, zone DMA: 97 pages in unavailable ranges1212worker # [ 0.042722] On node 0, zone DMA32: 43 pages in unavailable ranges1213worker # [ 0.043727] ACPI: PM-Timer IO Port: 0x6081214worker # [ 0.043744] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])1215worker # [ 0.043775] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-231216worker # [ 0.043778] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)1217worker # [ 0.043780] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)1218worker # [ 0.043781] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)1219worker # [ 0.043782] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)1220worker # [ 0.043783] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)1221worker # [ 0.043786] ACPI: Using ACPI (MADT) for SMP configuration information1222worker # [ 0.043787] ACPI: HPET id: 0x8086a201 base: 0xfed000001223worker # [ 0.043793] TSC deadline timer available1224worker # [ 0.043798] CPU topo: Max. logical packages: 11225worker # [ 0.043799] CPU topo: Max. logical dies: 11226worker # [ 0.043800] CPU topo: Max. dies per package: 11227worker # [ 0.043804] CPU topo: Max. threads per core: 11228worker # [ 0.043805] CPU topo: Num. cores per package: 11229worker # [ 0.043806] CPU topo: Num. threads per package: 11230worker # [ 0.043806] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs1231worker # [ 0.043831] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()1232worker # [ 0.043872] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]1233worker # [ 0.043873] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]1234worker # [ 0.043875] [mem 0xc0000000-0xfed1bfff] available for PCI devices1235worker # [ 0.043877] Booting paravirtualized kernel on KVM1236worker # [ 0.043882] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns1237worker # [ 0.049034] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:11238worker # [ 0.052524] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u20971521239worker # [ 0.052592] kvm-guest: PV spinlocks disabled, single CPU1240worker # [ 0.052594] 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/j6lk78pska82akk1m713f61nnzkhq1wz-nixos-system-worker-test/init regInfo=/nix/store/mpzwiw4bqr8ybpllmvpi3bjc25rv2wf5-closure-info/registration console=ttyS0,115200n8 console=tty01241worker # [ 0.052730] Unknown kernel command line parameters "regInfo=/nix/store/mpzwiw4bqr8ybpllmvpi3bjc25rv2wf5-closure-info/registration", will be passed to user space.1242worker # [ 0.052751] random: crng init done1243worker # [ 0.052752] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes1244worker # [ 0.056183] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)1245worker # [ 0.057320] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1246worker # [ 0.057361] Fallback order for Node 0: 01247worker # [ 0.057365] Built 1 zonelists, mobility grouping on. Total pages: 5241471248worker # [ 0.057367] Policy zone: DMA321249worker # [ 0.060281] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1250worker # [ 0.067523] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11251worker # [ 0.073031] allocated 4194304 bytes of page_ext1252worker # [ 0.083837] ftrace: allocating 48731 entries in 192 pages1253worker # [ 0.083842] ftrace: allocated 192 pages with 2 groups1254worker # [ 0.084839] Dynamic Preempt: lazy1255worker # [ 0.085046] rcu: Preemptible hierarchical RCU implementation.1256worker # [ 0.085047] rcu: RCU event tracing is enabled.1257worker # [ 0.085048] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1258worker # [ 0.085049] Trampoline variant of Tasks RCU enabled.1259worker # [ 0.085050] Rude variant of Tasks RCU enabled.1260worker # [ 0.085050] Tracing variant of Tasks RCU enabled.1261worker # [ 0.085051] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.1262worker # [ 0.085052] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11263worker # [ 0.085077] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1264worker # [ 0.085079] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1265worker # [ 0.085080] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1266worker # [ 0.090767] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 161267worker # [ 0.091078] rcu: srcu_init: Setting srcu_struct sizes based on contention.1268worker # [ 0.091087] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns1269worker # [ 0.091205] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1270worker # [ 0.098029] Console: colour VGA+ 80x251271worker # [ 0.098033] printk: legacy console [tty0] enabled1272worker # [ 0.143298] printk: legacy console [ttyS0] enabled1273worker # [ 0.317150] ACPI: Core revision 202508071274worker # [ 0.318663] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns1275worker # [ 0.321441] APIC: Switch to symmetric I/O mode setup1276worker # [ 0.322969] x2apic enabled1277worker # [ 0.324172] APIC: Switched APIC routing to: physical x2apic1278worker # [ 0.326927] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-11279worker # [ 0.328932] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns1280worker # [ 0.331811] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998)1281worker # [ 0.332892] x86/cpu: User Mode Instruction Prevention (UMIP) activated1282worker # [ 0.334967] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 1271283worker # [ 0.335808] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 01284worker # [ 0.336813] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto1285worker # [ 0.337808] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl1286worker # [ 0.339807] Spectre V2 : Mitigation: Retpolines1287worker # [ 0.340807] RETBleed: Mitigation: untrained return thunk1288worker # [ 0.341807] Speculative Return Stack Overflow: Mitigation: SMT disabled1289worker # [ 0.343807] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization1290worker # [ 0.344807] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT1291worker # [ 0.345807] Spectre V2 : Enabling Speculation Barrier for firmware calls1292worker # [ 0.346807] active return thunk: retbleed_return_thunk1293worker # [ 0.347811] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier1294worker # [ 0.349829] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'1295worker # [ 0.351808] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'1296worker # [ 0.352808] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'1297worker # [ 0.354808] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 2561298worker # [ 0.355807] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.1299worker # [ 0.382149] Freeing SMP alternatives memory: 44K1300worker # [ 0.382809] pid_max: default: 32768 minimum: 3011301worker # [ 0.384820] LSM: initializing lsm=capability,landlock,yama,bpf,ima1302worker # [ 0.385904] landlock: Up and running.1303worker # [ 0.387542] Yama: becoming mindful.1304worker # [ 0.388692] LSM support for eBPF active1305worker # [ 0.389944] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)1306worker # [ 0.390852] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)1307worker # [ 0.393089] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0)1308worker # [ 0.394444] Performance Events: Fam17h+ core perfctr, AMD PMU driver.1309worker # [ 0.394817] ... version: 01310worker # [ 0.395809] ... bit width: 481311worker # [ 0.396809] ... generic counters: 61312worker # [ 0.397809] ... generic bitmap: 000000000000003f1313worker # [ 0.398808] ... fixed-purpose counters: 01314worker # [ 0.399808] ... fixed-purpose bitmap: 00000000000000001315worker # [ 0.400808] ... value mask: 0000ffffffffffff1316worker # [ 0.401808] ... max period: 00007fffffffffff1317worker # [ 0.402808] ... global_ctrl mask: 000000000000003f1318worker # [ 0.403937] signal: max sigframe size: 17761319worker # [ 0.404951] rcu: Hierarchical SRCU implementation.1320worker # [ 0.405813] rcu: Max phase no-delay instances is 400.1321worker # [ 0.411016] smp: Bringing up secondary CPUs ...1322worker # [ 0.411830] smp: Brought up 1 node, 1 CPU1323worker # [ 0.412811] smpboot: Total of 1 processors activated (6199.99 BogoMIPS)1324worker # [ 0.414099] Memory: 1971572K/2096588K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115548K reserved, 0K cma-reserved)1325worker # [ 0.415346] devtmpfs: initialized1326worker # [ 0.416091] x86/mm: Memory block size: 128MB1327worker # [ 0.418029] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1328worker # [ 0.418846] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1329worker # [ 0.419976] pinctrl core: initialized pinctrl subsystem1330worker # [ 0.421190] PM: RTC time: 18:06:01, date: 2026-08-301331worker # [ 0.425738] NET: Registered PF_NETLINK/PF_ROUTE protocol family1332worker # [ 0.427509] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations1333worker # [ 0.428855] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1334worker # [ 0.430130] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1335worker # [ 0.430833] audit: initializing netlink subsys (disabled)1336worker # [ 0.432222] thermal_sys: Registered thermal governor 'fair_share'1337worker # [ 0.432224] thermal_sys: Registered thermal governor 'bang_bang'1338worker # [ 0.432809] thermal_sys: Registered thermal governor 'step_wise'1339worker # [ 0.433817] audit: type=2000 audit(1788113161.004:1): state=initialized audit_enabled=0 res=11340worker # [ 0.435816] thermal_sys: Registered thermal governor 'user_space'1341worker # [ 0.435818] thermal_sys: Registered thermal governor 'power_allocator'1342worker # [ 0.436863] cpuidle: using governor menu1343worker # [ 0.440056] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51344worker # [ 0.441203] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]1345worker # [ 0.441815] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry1346worker # [ 0.443624] PCI: Using configuration type 1 for base access1347worker # [ 0.445169] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.1348worker # [ 0.452355] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1349worker # [ 0.452810] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page1350worker # [ 0.453810] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1351worker # [ 0.458811] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page1352worker # [ 0.474633] ACPI: Added _OSI(Module Device)1353worker # [ 0.475828] ACPI: Added _OSI(Processor Device)1354worker # [ 0.477820] ACPI: Added _OSI(Processor Aggregator Device)1355worker # [ 0.483365] ACPI: 1 ACPI AML tables successfully acquired and loaded1356worker # [ 0.491155] ACPI: Interpreter enabled1357worker # [ 0.491831] ACPI: PM: (supports S0 S3 S4 S5)1358worker # [ 0.496813] ACPI: Using IOAPIC for interrupt routing1359worker # [ 0.497942] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug1360worker # [ 0.502826] PCI: Using E820 reservations for host bridge windows1361worker # [ 0.504471] ACPI: Enabled 2 GPEs in block 00 to 3F1362worker # [ 0.523547] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1363worker # [ 0.526819] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1364worker # [ 0.527945] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]1365worker # [ 0.528929] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]1366worker # [ 0.532469] PCI host bridge to bus 0000:001367worker # [ 0.533778] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]1368worker # [ 0.536091] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]1369worker # [ 0.537812] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]1370worker # [ 0.538816] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]1371worker # [ 0.539810] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]1372worker # [ 0.540824] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]1373worker # [ 0.541816] pci_bus 0000:00: root bus resource [bus 00-ff]1374worker # [ 0.544041] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint1375worker # [ 0.545736] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint1376worker # [ 0.548910] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]1377worker # [ 0.549844] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]1378worker # [ 0.550871] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]1379worker # [ 0.552079] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]1380worker # [ 0.554060] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1381worker # [ 0.556827] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f]1382worker # [ 0.557828] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]1383worker # [ 0.558890] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]1384worker # [ 0.559822] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]1385worker # [ 0.562269] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1386worker # [ 0.565828] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf]1387worker # [ 0.566822] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]1388worker # [ 0.567856] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]1389worker # [ 0.570240] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1390worker # [ 0.572836] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df]1391worker # [ 0.573824] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]1392worker # [ 0.574873] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]1393worker # [ 0.577249] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1394worker # [ 0.579993] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff]1395worker # [ 0.581836] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]1396worker # [ 0.582876] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]1397worker # [ 0.585233] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1398worker # [ 0.587826] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f]1399worker # [ 0.588825] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]1400worker # [ 0.589892] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]1401worker # [ 0.592050] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1402worker # [ 0.594830] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff]1403worker # [ 0.595850] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]1404worker # [ 0.596869] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]1405worker # [ 0.599302] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1406worker # [ 0.602850] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f]1407worker # [ 0.603828] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]1408worker # [ 0.604936] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]1409worker # [ 0.606935] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]1410worker # [ 0.609428] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1411worker # [ 0.612888] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]1412worker # [ 0.614099] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]1413worker # [ 0.616000] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1414worker # [ 0.618848] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f]1415worker # [ 0.619825] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]1416worker # [ 0.620882] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]1417worker # [ 0.623247] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1418worker # [ 0.625836] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f]1419worker # [ 0.626849] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]1420worker # [ 0.627857] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]1421worker # [ 0.630067] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint1422worker # [ 0.631872] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f]1423worker # [ 0.633237] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint1424worker # [ 0.634889] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f]1425worker # [ 0.636245] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint1426worker # [ 0.637880] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f]1427worker # [ 0.639328] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint1428worker # [ 0.641836] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]1429worker # [ 0.644456] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint1430worker # [ 0.646503] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO1431worker # [ 0.648453] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint1432worker # [ 0.651675] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf]1433worker # [ 0.652824] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]1434worker # [ 0.654573] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint1435worker # [ 0.656870] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]1436worker # [ 0.664289] ACPI: PCI: Interrupt link LNKA configured for IRQ 101437worker # [ 0.664974] ACPI: PCI: Interrupt link LNKB configured for IRQ 101438worker # [ 0.665980] ACPI: PCI: Interrupt link LNKC configured for IRQ 111439worker # [ 0.666964] ACPI: PCI: Interrupt link LNKD configured for IRQ 111440worker # [ 0.667975] ACPI: PCI: Interrupt link LNKE configured for IRQ 101441worker # [ 0.668979] ACPI: PCI: Interrupt link LNKF configured for IRQ 101442worker # [ 0.670017] ACPI: PCI: Interrupt link LNKG configured for IRQ 111443worker # [ 0.670963] ACPI: PCI: Interrupt link LNKH configured for IRQ 111444worker # [ 0.671887] ACPI: PCI: Interrupt link GSIA configured for IRQ 161445worker # [ 0.672829] ACPI: PCI: Interrupt link GSIB configured for IRQ 171446worker # [ 0.673828] ACPI: PCI: Interrupt link GSIC configured for IRQ 181447worker # [ 0.674833] ACPI: PCI: Interrupt link GSID configured for IRQ 191448worker # [ 0.675842] ACPI: PCI: Interrupt link GSIE configured for IRQ 201449worker # [ 0.676831] ACPI: PCI: Interrupt link GSIF configured for IRQ 211450worker # [ 0.677849] ACPI: PCI: Interrupt link GSIG configured for IRQ 221451worker # [ 0.678838] ACPI: PCI: Interrupt link GSIH configured for IRQ 231452worker # [ 0.681307] iommu: Default domain type: Translated1453worker # [ 0.681822] iommu: DMA domain TLB invalidation policy: lazy mode1454worker # [ 0.683237] ACPI: bus type USB registered1455worker # [ 0.684048] usbcore: registered new interface driver usbfs1456worker # [ 0.684839] usbcore: registered new interface driver hub1457worker # [ 0.685840] usbcore: registered new device driver usb1458worker # [ 0.688061] NetLabel: Initializing1459worker # [ 0.688810] NetLabel: domain hash size = 1281460worker # [ 0.689810] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO1461worker # [ 0.690942] NetLabel: unlabeled traffic allowed by default1462worker # [ 0.691839] PCI: Using ACPI for IRQ routing1463hub # [ 127.775484] tailscaled[660]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ...1464hub # [ 127.779121] tailscaled[660]: 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 unreachable1465hub # [ 127.783281] tailscaled[660]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ...1466worker # [ 0.791921] pci 0000:00:01.0: vgaarb: setting as boot VGA device1467worker # [ 0.792804] pci 0000:00:01.0: vgaarb: bridge control possible1468worker # [ 0.792804] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none1469worker # [ 0.792827] vgaarb: loaded1470worker # [ 0.794076] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 01471worker # [ 0.794811] hpet0: 3 comparators, 64-bit 100.000000 MHz counter1472worker # [ 0.798995] clocksource: Switched to clocksource kvm-clock1473worker # [ 0.803537] VFS: Disk quotas dquot_6.6.01474worker # [ 0.804854] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1475worker # [ 0.807100] pnp: PnP ACPI init1476worker # [ 0.808255] ACPI: IRQ 4 override to edge(!), high(!)1477worker # [ 0.809806] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved1478worker # [ 0.812167] pnp: PnP ACPI: found 6 devices1479worker # [ 0.820425] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns1480worker # [ 0.822862] clocksource: Switched to clocksource acpi_pm1481worker # [ 0.824480] NET: Registered PF_INET protocol family1482worker # [ 0.826592] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)1483worker # [ 0.847066] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)1484worker # [ 0.849418] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1485worker # [ 0.851538] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)1486worker # [ 0.853987] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)1487worker # [ 0.856152] TCP: Hash tables configured (established 16384 bind 16384)1488worker # [ 0.858176] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)1489worker # [ 0.860420] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)1490worker # [ 0.862393] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)1491worker # [ 0.864691] NET: Registered PF_UNIX/PF_LOCAL protocol family1492worker # [ 0.866527] NET: Registered PF_XDP protocol family1493worker # [ 0.868119] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]1494worker # [ 0.869840] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]1495worker # [ 0.871459] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]1496worker # [ 0.873341] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]1497worker # [ 0.875464] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]1498worker # [ 0.877400] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]1499worker # [ 0.880149] ACPI: \_SB_.GSIA: Enabled at IRQ 161500worker # [ 0.883089] ACPI: \_SB_.GSIB: Enabled at IRQ 171501worker # [ 0.885353] ACPI: \_SB_.GSIC: Enabled at IRQ 181502worker # [ 0.887980] ACPI: \_SB_.GSID: Enabled at IRQ 191503worker # [ 0.890276] PCI: CLS 0 bytes, default 641504worker # [ 0.891923] Trying to unpack rootfs image as initramfs...1505worker # [ 0.898012] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns1506worker # [ 0.945264] Initialise system trusted keyrings1507worker # [ 0.949891] workingset: timestamp_bits=40 max_order=19 bucket_order=01508worker # [ 0.977300] Key type asymmetric registered1509worker # [ 0.981802] Asymmetric key parser 'x509' registered1510worker # [ 0.986866] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)1511worker # [ 0.992839] io scheduler mq-deadline registered1512worker # [ 0.997798] io scheduler kyber registered1513worker # [ 1.001360] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1514worker # [ 1.007268] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1515worker # [ 1.014421] Linux agpgart interface v0.1031516worker # [ 1.017918] ACPI: bus type drm_connector registered1517worker # [ 1.022061] usbcore: registered new interface driver usbserial_generic1518worker # [ 1.023842] usbserial: USB Serial support registered for generic1519worker # [ 1.028809] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1520worker # [ 1.031240] drop_monitor: Initializing network drop monitor service1521worker # [ 1.037988] NET: Registered PF_INET6 protocol family1522worker # [ 1.040127] Segment Routing with IPv61523worker # [ 1.044811] In-situ OAM (IOAM) with IPv61524worker # [ 1.046570] IPI shorthand broadcast: enabled1525worker # [ 1.057232] sched_clock: Marking stable (823028201, 233718797)->(1289498116, -232751118)1526worker # [ 1.063092] registered taskstats version 11527worker # [ 1.064628] Loading compiled-in X.509 certificates1528worker # [ 1.079509] Demotion targets for Node 0: null1529worker # [ 1.084042] Key type .fscrypt registered1530worker # [ 1.087791] Key type fscrypt-provisioning registered1531worker # [ 1.089988] ima: No TPM chip found, activating TPM-bypass!1532worker # [ 1.095789] ima: Allocated hash algorithm: sha11533worker # [ 1.097285] ima: No architecture policies found1534worker # [ 1.102031] PM: Magic number: 6:243:1411535worker # [ 1.103337] acpi device:12: hash matches1536worker # [ 1.109184] RAS: Correctable Errors collector initialized.1537worker # [ 1.125135] clk: Disabling unused clocks1538worker # [ 1.129789] PM: genpd: Disabling unused power domains1539worker # [ 1.458248] Freeing initrd memory: 29120K1540worker # [ 1.465144] Freeing unused decrypted memory: 2028K1541worker # [ 1.470023] Freeing unused kernel image (initmem) memory: 3644K1542worker # [ 1.472280] Write protecting the kernel read-only data: 32768k1543worker # [ 1.475379] Freeing unused kernel image (text/rodata gap) memory: 1216K1544worker # [ 1.478356] Freeing unused kernel image (rodata/data gap) memory: 756K1545worker # [ 1.538937] x86/mm: Checked W+X mappings: passed, no W+X pages found.1546worker # [ 1.541292] Run /init as init process1547worker # [ 1.555191] systemd[1]: Inserted module 'autofs4'1548worker # [ 1.582876] fuse: init (API version 7.45)1549worker # [ 1.590172] ACPI: \_SB_.GSIG: Enabled at IRQ 221550worker # [ 1.593870] ACPI: \_SB_.GSIH: Enabled at IRQ 231551worker # [ 1.599081] ACPI: \_SB_.GSIE: Enabled at IRQ 201552worker # [ 1.603351] ACPI: \_SB_.GSIF: Enabled at IRQ 211553worker # [ 1.641030] systemd[1]: Successfully made /usr/ read-only.1554worker # [ 1.978350] systemd[1]: systemd 261.2 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)1555worker # [ 1.987642] systemd[1]: Detected virtualization kvm.1556worker # [ 1.989789] systemd[1]: Detected architecture x86-64.1557worker # [ 1.991323] systemd[1]: Running in initrd.1558worker # [ 1.993518] systemd[1]: Initializing machine ID from random generator.1559worker # [ 1.995598] systemd[1]: Hostname set to <worker>.1560worker # [ 2.197127] systemd[1]: bpf-restrict-fs: LSM BPF program attached1561worker # [ 2.250156] systemd[1]: Queued start job for default target Initrd Default Target.1562worker # [ 2.255638] systemd[1]: Created slice Slice /system/modprobe.1563worker # [ 2.257745] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1564worker # [ 2.259998] systemd[1]: Expecting device /dev/disk/by-label/nix-store...1565worker # [ 2.261935] systemd[1]: Expecting device /dev/disk/by-label/nixos...1566worker # [ 2.263827] systemd[1]: Reached target Path Units.1567worker # [ 2.265275] systemd[1]: Reached target Slice Units.1568worker # [ 2.266884] systemd[1]: Reached target Swaps.1569worker # [ 2.268202] systemd[1]: Reached target Timer Units.1570worker # [ 2.269960] systemd[1]: Listening on D-Bus System Message Bus Socket.1571worker # [ 2.272244] systemd[1]: Listening on Journal Socket (/dev/log).1572worker # [ 2.274448] systemd[1]: Listening on Journal Sockets.1573worker # [ 2.276396] systemd[1]: Listening on udev Control Socket.1574worker # [ 2.278227] systemd[1]: Listening on udev Kernel Socket.1575worker # [ 2.279840] systemd[1]: Reached target Socket Units.1576worker # [ 2.282554] systemd[1]: Starting Create List of Static Device Nodes...1577worker # [ 2.292054] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1578worker # [ 2.301828] systemd[1]: Starting Load Kernel Module configfs...1579worker # [ 2.311818] systemd[1]: Starting Journal Service...1580worker # [ 2.325826] systemd[1]: Starting Load Kernel Modules...1581worker # [ 2.333682] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1582worker # [ 2.346260] netfs: FS-Cache loaded1583worker # [ 2.349979] systemd[1]: Starting Coldplug All udev Devices...1584worker # [ 2.371636] 9pnet: Installing 9P2000 support1585worker # [ 2.374874] systemd[1]: Finished Create List of Static Device Nodes.1586worker # [ 2.388978] systemd[1]: modprobe@configfs.service: Deactivated successfully.1587worker # [ 2.403782] systemd-journald[68]: Collecting audit messages is disabled.1588worker # [ 2.408047] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1589worker # [ 2.421076] systemd[1]: Finished Load Kernel Module configfs.1590worker # [ 2.423840] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1591worker # [ 2.430412] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1592worker # [ 2.442433] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1593worker # [ 2.452615] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1594worker # [ 2.466820] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1595worker # [ 2.483928] systemd[1]: Finished Load Kernel Modules.1596worker # [ 2.496852] systemd[1]: Starting Apply Kernel Variables...1597worker # [ 2.518899] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1598worker # [ 2.533972] systemd[1]: Starting Create Static Device Nodes in /dev...1599worker # [ 2.554758] systemd[1]: Finished Apply Kernel Variables.1600worker # [ 2.347393] systemd-modules-load[69]: Inserted module 'dm_mod'[ 2.583346] systemd[1]: Started Journal Service.1601worker # 1602worker # [ 2.353714] systemd-modules-load[69]: Inserted module 'virtio_balloon'1603worker # [ 2.356698] systemd-modules-load[69]: Inserted module 'virtio_gpu'1604worker # [ 2.363368] systemd[1]: Finished Create Static Device Nodes in /dev.1605worker # [ 2.377135] systemd[1]: Reached target Preparation for Local File Systems.1606worker # [ 2.381122] systemd[1]: Reached target Local File Systems.1607worker # [ 2.384423] systemd[1]: Starting Create System Files and Directories...1608worker # [ 2.395822] systemd[1]: Starting Rule-based Manager for Device Events and Files...1609worker # [ 2.431230] systemd[1]: Finished Create System Files and Directories.1610worker # [ 2.445793] systemd[1]: Finished Coldplug All udev Devices.1611worker # [ 2.452620] systemd-udevd[83]: Using default interface naming scheme 'v261'.1612worker # [ 2.472117] systemd[1]: Started Rule-based Manager for Device Events and Files.1613worker # [ 2.473935] systemd[1]: Reached target System Initialization.1614worker # [ 2.475426] systemd[1]: Reached target Basic System.1615worker # [ 2.985382] virtio_blk virtio4: 1/0/0 default/read/poll queues1616worker # [ 2.989077] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121617worker # [ 3.014779] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1618worker # [ 3.021379] serio: i8042 KBD port at 0x60,0x64 irq 11619worker # [ 3.031127] ehci-pci 0000:00:1d.7: EHCI Host Controller1620worker # [ 3.032311] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11621worker # [ 3.035151] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001622worker # [ 3.043784] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001623worker # [ 3.046285] serio: i8042 AUX port at 0x60,0x64 irq 121624worker # [ 3.047605] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181625worker # [ 3.050751] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11626worker # [ 3.053620] usb usb1: Product: EHCI Host Controller1627worker # [ 3.055767] usb usb1: Manufacturer: Linux 6.18.46 ehci_hcd1628worker # [ 3.057330] usb usb1: SerialNumber: 0000:00:1d.71629worker # [ 3.060012] hub 1-0:1.0: USB hub found1630worker # [ 3.061498] hub 1-0:1.0: 6 ports detected1631worker # [ 3.067374] virtio_blk virtio5: 1/0/0 default/read/poll queues1632worker # [ 3.072968] uhci_hcd 0000:00:1d.0: UHCI Host Controller1633worker # [ 3.077290] virtio_blk virtio5: [vdb] 2136112 512-byte logical blocks (1.09 GB/1.02 GiB)1634worker # [ 3.083294] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21635worker # [ 3.099937] uhci_hcd 0000:00:1d.0: detected 2 ports1636worker # [ 3.103286] SCSI subsystem initialized1637worker # [ 3.106663] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2401638worker # [ 3.115022] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181639worker # [ 3.116742] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11640worker # [ 2.911200] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1641worker # [ 2.914397] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1642worker # [ 2.917867] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1643worker # [ 3.157438] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01644worker # [ 3.160739] usb usb2: Product: UHCI Host Controller1645worker # [ 2.934552] systemd[1]: Starting Virtual Console Setup...1646worker # [ 3.179525] usb usb2: Manufacturer: Linux 6.18.46 uhci_hcd1647worker # [ 3.198407] usb usb2: SerialNumber: 0000:00:1d.01648worker # [ 3.203796] hub 2-0:1.0: USB hub found1649worker # [ 2.980411] systemd-vconsole-setup[106]: Configuration of first virtual console was skipped, ignoring remaining ones.1650worker # [ 2.986587] systemd[1]: Finished Virtual Console Setup.1651worker # [ 3.223761] hub 2-0:1.0: 2 ports detected1652worker # [ 3.233262] uhci_hcd 0000:00:1d.1: UHCI Host Controller1653worker # [ 3.234376] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31654worker # [ 3.004376] systemd[1]: Found device /dev/disk/by-label/nixos.1655worker # [ 3.006874] systemd[1]: Reached target Initrd Root Device.1656worker # [ 3.009286] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1657worker # [ 3.257775] uhci_hcd 0000:00:1d.1: detected 2 ports1658worker # [ 3.026213] systemd[1]: Found device /dev/disk/by-label/nix-store.1659worker # [ 3.262436] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2601660worker # [ 3.268980] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181661worker # [ 3.270807] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11662worker # [ 3.274268] usb usb3: Product: UHCI Host Controller1663worker # [ 3.045359] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks1664worker # [ 3.283547] usb usb3: Manufacturer: Linux 6.18.46 uhci_hcd1665worker # [ 3.284799] usb usb3: SerialNumber: 0000:00:1d.11666worker # [ 3.287904] hub 3-0:1.0: USB hub found1667worker # [ 3.290150] hub 3-0:1.0: 2 ports detected1668worker # [ 3.295349] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1669worker # [ 3.297137] uhci_hcd 0000:00:1d.2: UHCI Host Controller1670worker # [ 3.298148] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41671worker # [ 3.300297] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1672worker # [ 3.301742] usb 1-1: new high-speed USB device number 2 using ehci-pci1673worker # [ 3.303463] uhci_hcd 0000:00:1d.2: detected 2 ports1674worker # [ 3.304625] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2801675worker # [ 3.306372] ahci 0000:00:1f.2: flags: 64bit ncq only1676worker # [ 3.310864] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181677worker # [ 3.313384] scsi host0: ahci1678worker # [ 3.315167] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11679worker # [ 3.317035] scsi host1: ahci1680worker # [ 3.318898] scsi host2: ahci1681worker # [ 3.320778] usb usb4: Product: UHCI Host Controller1682worker # [ 3.321677] usb usb4: Manufacturer: Linux 6.18.46 uhci_hcd1683worker # [ 3.323132] scsi host3: ahci1684worker # [ 3.324985] scsi host4: ahci1685worker # [ 3.326875] scsi host5: ahci1686worker # [ 3.327584] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11687worker # [ 3.329848] usb usb4: SerialNumber: 0000:00:1d.21688worker # [ 3.331555] hub 4-0:1.0: USB hub found1689worker # [ 3.332797] hub 4-0:1.0: 2 ports detected1690worker # [ 3.333660] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11691worker # [ 3.342759] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11692worker # [ 3.344276] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11693worker # [ 3.355640] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11694worker # [ 3.359937] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11695worker # [ 3.433838] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001696worker # [ 3.435338] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101697worker # [ 3.437191] usb 1-1: Product: QEMU USB Tablet1698worker # [ 3.438281] usb 1-1: Manufacturer: QEMU1699worker # [ 3.439325] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11700worker # [ 3.453301] hid: raw HID events driver (C) Jiri Kosina1701worker # [ 3.668626] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1702worker # [ 3.670036] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001703worker # [ 3.671571] ata3.00: applying bridge limits1704worker # [ 3.672897] ata6: SATA link down (SStatus 0 SControl 300)1705worker # [ 3.674275] ata4: SATA link down (SStatus 0 SControl 300)1706worker # [ 3.675832] ata5: SATA link down (SStatus 0 SControl 300)1707worker # [ 3.677243] ata2: SATA link down (SStatus 0 SControl 300)1708worker # [ 3.678609] ata1: SATA link down (SStatus 0 SControl 300)1709worker # [ 3.679906] ata3.00: configured for UDMA/1001710worker # [ 3.681258] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51711hub # [ 130.780265] tailscaled[660]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1712hub # [ 130.784189] tailscaled[660]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ...1713hub # [ 130.787187] tailscaled[660]: 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 unreachable1714hub # [ 130.790990] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...1715worker # [ 3.712043] usbcore: registered new interface driver usbhid1716worker # [ 3.715748] usbhid: USB HID core driver1717worker # [ 3.721774] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21718worker # [ 3.724316] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1719worker # [ 3.726230] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01720worker # [ 3.736892] cdrom: Uniform CD-ROM driver Revision: 3.201721hub # [ 133.814720] tailscaled[660]: 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": context deadline exceeded1722hub # [ 133.818864] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...1723hub # [ 133.824415] tailscaled[660]: 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 unreachable1724hub # [ 133.829351] tailscaled[660]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ...1725hub # [ 136.830570] tailscaled[660]: bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1726hub # [ 136.834673] tailscaled[660]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ...1727hub # [ 136.837888] tailscaled[660]: bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 46.101.74.201:443: connect: network is unreachable1728hub # [ 136.841936] tailscaled[660]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ...1729hub # [ 139.839304] tailscaled[660]: bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1730hub # [ 139.844628] tailscaled[660]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ...1731hub # [ 139.846903] tailscaled[660]: bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 207.148.3.137:443: connect: network is unreachable1732hub # [ 139.851105] tailscaled[660]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ...1733hub # [ 142.845710] tailscaled[660]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1734hub # [ 142.850381] tailscaled[660]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ...1735hub # [ 142.852478] tailscaled[660]: bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 104.248.8.210:443: connect: network is unreachable1736hub # [ 142.856358] tailscaled[660]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ...1737hub # [ 145.850869] tailscaled[660]: bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded1738worker # [ 20.463434] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1739worker # [ 20.467795] systemd[1]: Mounting /sysroot...1740worker # [ 21.070810] EXT4-fs (vda): mounted filesystem b7a37648-fe9e-4602-ac29-1c377ee82bd8 r/w with ordered data mode. Quota mode: none.1741worker # [ 20.842858] systemd[1]: Mounted /sysroot.1742worker # [ 20.845981] systemd[1]: Reached target Initrd Root File System.1743worker # [ 20.853421] systemd[1]: Mounting /sysroot/nix/.ro-store...1744worker # [ 20.862173] systemd[1]: Mounting /sysroot/nix/.rw-store...1745worker # [ 20.869325] systemd[1]: Mounting /sysroot/run...1746worker # [ 20.894399] systemd[1]: Mounting /sysroot/tmp/shared...1747worker # [ 20.909298] systemd[1]: Mounting /sysroot/tmp/xchg...1748worker # [ 20.932332] systemd[1]: Starting Mountpoints Configured in the Real Root...1749worker # [ 20.988716] systemd[1]: Mounted /sysroot/nix/.rw-store.1750worker # [ 21.225373] erofs (device vdb): mounted with root inode @ nid 36.1751worker # [ 21.006386] systemd-sysroot-fstab-check[157]: /sysroot should be mounted in the initrd, will request daemon-reload.1752worker # [ 21.009434] systemd[1]: Mounted /sysroot/run.1753worker # [ 21.021134] systemd[1]: Mounted /sysroot/nix/.ro-store.1754worker # [ 21.258306] 9p: Installing v9fs 9p2000 file system support1755worker # [ 21.037264] systemd[1]: Starting rw-sysroot-nix-store.service...1756worker # [ 21.039081] systemd[1]: Reload requested from client PID 157 ('systemd-sysroot') (unit initrd-parse-etc.service)...1757worker # [ 21.042546] systemd[1]: Reloading...1758worker # [ 21.175980] systemd[1]: Reloading finished in 129 ms.1759worker # [ 21.193412] systemd-sysroot-fstab-check[157]: Requesting initrd-fs.target/start/replace...1760worker # [ 21.198860] systemd[1]: Mounted /sysroot/tmp/shared.1761worker # [ 21.201276] systemd[1]: Mounted /sysroot/tmp/xchg.1762worker # [ 21.202615] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1763worker # [ 21.205145] systemd[1]: Finished rw-sysroot-nix-store.service.1764worker # [ 21.210445] systemd-sysroot-fstab-check[157]: Requesting swap.target/start/replace...1765worker # [ 21.214855] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1766worker # [ 21.217372] systemd[1]: Finished Mountpoints Configured in the Real Root.1767worker # [ 21.219389] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1768worker # [ 21.226234] systemd[1]: Starting rw-sysroot-nix-store.service...1769worker # [ 21.241711] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1770worker # [ 21.244783] systemd[1]: Finished rw-sysroot-nix-store.service.1771worker # [ 21.464986] systemd[1]: Mounting /sysroot/nix/store...1772worker # [ 21.490583] systemd[1]: Mounted /sysroot/nix/store.1773worker # [ 21.492764] systemd[1]: Reached target Initrd File Systems.1774worker # [ 21.495622] systemd[1]: Starting Find NixOS closure...1775worker # [ 21.498826] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1776worker # [ 21.524510] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1777worker # [ 21.528976] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1778worker # [ 21.540196] systemd[1]: Finished Find NixOS closure.1779worker # [ 21.543601] systemd[1]: Reached target Initrd Default Target.1780worker # [ 21.546300] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1781worker # [ 21.567095] systemd[1]: Stopped target Initrd Default Target.1782worker # [ 21.568914] systemd[1]: Stopped target Basic System.1783worker # [ 21.571548] systemd[1]: Stopped target Initrd Root Device.1784worker # [ 21.573189] systemd[1]: Stopped target Path Units.1785worker # [ 21.574441] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1786worker # [ 21.576671] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1787worker # [ 21.579525] systemd[1]: Stopped target Slice Units.1788worker # [ 21.581247] systemd[1]: Stopped target Socket Units.1789worker # [ 21.583284] systemd[1]: Stopped target System Initialization.1790worker # [ 21.584897] systemd[1]: Stopped target Swaps.1791worker # [ 21.586824] systemd[1]: Stopped target Timer Units.1792worker # [ 21.588472] systemd[1]: dbus.socket: Deactivated successfully.1793worker # [ 21.591282] systemd[1]: Closed D-Bus System Message Bus Socket.1794worker # [ 21.592738] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1795worker # [ 21.594672] systemd[1]: Stopped Find NixOS closure.1796worker # [ 21.596243] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1797worker # [ 21.600177] systemd[1]: Starting rw-sysroot-nix-store.service...1798worker # [ 21.601995] systemd[1]: systemd-sysctl.service: Deactivated successfully.1799worker # [ 21.604833] systemd[1]: Stopped Apply Kernel Variables.1800worker # [ 21.606551] systemd[1]: systemd-modules-load.service: Deactivated successfully.1801worker # [ 21.611390] systemd[1]: Stopped Load Kernel Modules.1802worker # [ 21.616962] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1803worker # [ 21.620327] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1804worker # [ 21.623300] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1805worker # [ 21.625423] systemd[1]: Stopped Create System Files and Directories.1806worker # [ 21.626955] systemd[1]: Stopped target Local File Systems.1807worker # [ 21.630227] systemd[1]: Stopped target Preparation for Local File Systems.1808worker # [ 21.631974] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1809worker # [ 21.634741] systemd[1]: Stopped Coldplug All udev Devices.1810worker # [ 21.637153] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1811worker # [ 21.640125] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1812worker # [ 21.641993] systemd[1]: Stopped Virtual Console Setup.1813worker # [ 21.655154] systemd[1]: systemd-udevd.service: Deactivated successfully.1814worker # [ 21.660249] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1815worker # [ 21.663541] systemd[1]: initrd-cleanup.service: Deactivated successfully.1816worker # [ 21.667229] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1817worker # [ 21.669716] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1818worker # [ 21.675180] systemd[1]: Finished rw-sysroot-nix-store.service.1819worker # [ 21.682169] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1820worker # [ 21.684170] systemd[1]: Closed udev Control Socket.1821worker # [ 21.686760] systemd[1]: Starting Cleanup udev Database...1822worker # [ 21.689250] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1823worker # [ 21.691124] systemd[1]: Stopped Create Static Device Nodes in /dev.1824worker # [ 21.692661] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1825worker # [ 21.695249] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1826worker # [ 21.696927] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1827worker # [ 21.699233] systemd[1]: Stopped Create List of Static Device Nodes.1828worker # [ 21.714865] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1829worker # [ 21.718334] systemd[1]: Finished Cleanup udev Database.1830worker # [ 21.720193] systemd[1]: Reached target Switch Root.1831worker # [ 21.722626] systemd[1]: Starting NixOS Activation...1832worker # [ 22.085856] initrd-nixos-activation-start[207]: booting system configuration /nix/store/j6lk78pska82akk1m713f61nnzkhq1wz-nixos-system-worker-test1833worker # [ 22.123209] initrd-nixos-activation-start[207]: running activation script...1834worker # [ 22.574698] initrd-nixos-activation-start[230]: setting up /etc...1835worker # [ 22.708135] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1836worker # [ 22.712345] systemd[1]: Finished NixOS Activation.1837worker # [ 22.716454] systemd[1]: Starting Switch Root...1838worker # [ 22.737132] systemd[1]: Switching root.1839worker # [ 23.100034] systemd-journald[68]: Received SIGTERM from PID 1 (systemd).1840worker: Guest root shell did not produce any data yet...1841worker: To debug, enter the VM and run 'systemctl status backdoor.service'.1842worker # [ 41.849997] NET: Registered PF_VSOCK protocol family1843worker # [ 42.214547] systemd[1]: systemd 261.2 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)1844worker # [ 42.226095] systemd[1]: Detected virtualization kvm.1845worker # [ 42.227950] systemd[1]: Detected architecture x86-64.1846worker # [ 42.229445] systemd[1]: Detected first boot.1847worker # [ 42.231497] systemd[1]: Initializing machine ID from random generator.1848worker # [ 42.579653] systemd[1]: bpf-restrict-fs: LSM BPF program attached1849worker # [ 51.882453] systemd[1]: Applying preset policy.1850worker # [ 52.259238] systemd[1]: Populated /etc with preset unit settings.1851worker # [ 52.360310] systemd[1]: initrd-switch-root.service: Deactivated successfully.1852worker # [ 52.362331] systemd[1]: Stopped initrd-switch-root.service.1853worker # [ 52.365058] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1854worker # [ 52.368352] systemd[1]: Created slice Slice /system/getty.1855worker # [ 52.370061] systemd[1]: Created slice Slice /system/tribuchet-agent.1856worker # [ 52.371904] systemd[1]: Created slice User and Session Slice.1857worker # [ 52.373294] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1858worker # [ 52.374928] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1859worker # [ 52.376512] systemd[1]: Expecting device /dev/hvc0...1860worker # [ 52.377586] systemd[1]: Expecting device /dev/ttyS0...1861worker # [ 52.378662] systemd[1]: Reached target Local Encrypted Volumes.1862worker # [ 52.379810] systemd[1]: Stopped target initrd-fs.target.1863worker # [ 52.380851] systemd[1]: Stopped target initrd-root-fs.target.1864worker # [ 52.381977] systemd[1]: Stopped target initrd-switch-root.target.1865worker # [ 52.383261] systemd[1]: Reached target Virtual Machines and Containers.1866worker # [ 52.384547] systemd[1]: Reached target Path Units.1867worker # [ 52.385581] systemd[1]: Reached target Remote File Systems.1868worker # [ 52.386764] systemd[1]: Reached target Slice Units.1869worker # [ 52.387820] systemd[1]: Reached target Swaps.1870worker # [ 52.389841] systemd[1]: Listening on Query the User Interactively for a Password.1871worker # [ 52.399335] systemd[1]: Listening on Process Core Dump Socket.1872worker # [ 52.401618] systemd[1]: Listening on Credential Encryption/Decryption.1873worker # [ 52.404376] systemd[1]: Listening on Factory Reset Management.1874worker # [ 52.405972] systemd[1]: Listening on Hostname Service Socket.1875worker # [ 52.409600] systemd[1]: Starting Journal Log Access Socket...1876worker # [ 52.411856] systemd[1]: Listening on Journal Audit Socket.1877worker # [ 52.414786] systemd[1]: Listening on Console Output Muting Service Socket.1878worker # [ 52.416629] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1879worker # [ 52.418727] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1880worker # [ 52.420663] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1881worker # [ 52.424055] systemd[1]: Listening on Disk Repartitioning Service Socket.1882worker # [ 52.425612] systemd[1]: Listening on udev Control Socket.1883worker # [ 52.426886] systemd[1]: Listening on udev Varlink Socket.1884worker # [ 52.430076] systemd[1]: Mounting Huge Pages File System...1885worker # [ 52.436252] systemd[1]: Mounting POSIX Message Queue File System...1886worker # [ 52.445307] systemd[1]: Mounting Kernel Debug File System...1887worker # [ 52.457341] systemd[1]: Mounting Kernel Trace File System...1888worker # [ 52.474463] systemd[1]: Starting Create List of Static Device Nodes...1889worker # [ 52.486330] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1890worker # [ 52.502300] systemd[1]: Starting Load Kernel Module configfs...1891worker # [ 52.504254] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1892worker # [ 52.508962] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1893worker # [ 52.511374] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1894worker # [ 52.520293] systemd[1]: Mounting FUSE Control File System...1895worker # [ 52.523280] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671896worker # [ 52.537307] systemd[1]: Starting Journal Service...1897worker # [ 52.544333] systemd[1]: Starting Load Kernel Modules...1898worker # [ 52.551262] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1899worker # [ 52.558294] systemd[1]: Starting Remount Root and Kernel File Systems...1900worker # [ 52.560298] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1901worker # [ 52.571352] systemd[1]: Starting Coldplug All udev Devices...1902worker # [ 52.578979] systemd[1]: Listening on Journal Log Access Socket.1903worker # [ 52.582469] systemd[1]: Mounted Huge Pages File System.1904worker # [ 52.585516] systemd[1]: Mounted POSIX Message Queue File System.1905worker # [ 52.588666] systemd[1]: Mounted Kernel Debug File System.1906worker # [ 52.592629] systemd[1]: Mounted Kernel Trace File System.1907worker # [ 52.598344] systemd[1]: Finished Create List of Static Device Nodes.1908worker # [ 52.602838] systemd[1]: modprobe@configfs.service: Deactivated successfully.1909worker # [ 52.608040] systemd[1]: Finished Load Kernel Module configfs.1910worker # [ 52.611786] systemd[1]: Mounted FUSE Control File System.1911worker # [ 52.620317] systemd[1]: Mounting Kernel Configuration File System...1912worker # [ 52.636364] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1913worker # [ 52.650966] systemd[1]: Mounted Kernel Configuration File System.1914worker # [ 52.685387] loop: module loaded1915worker # [ 52.692268] EXT4-fs (vda): re-mounted b7a37648-fe9e-4602-ac29-1c377ee82bd8.1916worker # [ 52.696024] systemd[1]: Finished Load Kernel Modules.1917worker # [ 52.701745] systemd-journald[300]: Collecting audit messages is enabled.1918worker # [ 52.704394] systemd[1]: Starting Firewall...1919worker # [ 52.713331] systemd[1]: Starting Apply Kernel Variables...1920worker # [ 52.720279] systemd[1]: Finished Remount Root and Kernel File Systems.1921worker # [ 52.723720] systemd[1]: Listening on Disk Image Download Service Socket.1922worker # [ 52.727355] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1923worker # [ 52.739296] systemd[1]: Starting Load/Save OS Random Seed...1924worker # [ 52.742302] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1925worker # [ 52.782312] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1926worker # [ 52.795295] systemd[1]: Starting Create Static Device Nodes in /dev...1927worker # [ 52.827857] systemd[1]: Finished Apply Kernel Variables.1928worker # [ 52.841173] systemd[1]: Started Journal Service.1929worker # [ 52.617750] systemd[1]: Queued start job for default target Multi-User System.1930worker # [ 52.628280] systemd[1]: Unnecessary job was removed for /dev/vdb.1931worker # [ 52.645199] systemd[1]: systemd-journald.service: Deactivated successfully.1932worker # [ 52.653422] systemd-modules-load[301]: Inserted module 'loop'1933worker # [ 52.660819] systemd[1]: Starting Flush Journal to Persistent Storage...1934worker # [ 52.707269] systemd[1]: Finished Create Static Device Nodes in /dev.1935worker # [ 52.710612] systemd[1]: Reached target Preparation for Local File Systems.1936worker # [ 52.725124] systemd-oomd[302]: No swap; memory pressure usage will be degraded1937worker # [ 52.733181] systemd[1]: Starting Rule-based Manager for Device Events and Files...1938worker # [ 52.734989] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1939worker # [ 52.982438] systemd-journald[300]: Received client request to flush runtime journal.1940worker # [ 53.763852] systemd-udevd[332]: Using default interface naming scheme 'v261'.1941worker # [ 53.768563] systemd[1]: Started Rule-based Manager for Device Events and Files.1942worker # [ 53.774309] systemd[1]: Finished Coldplug All udev Devices.1943worker # [ 53.782367] systemd[1]: Mounting /run/wrappers...1944worker # [ 53.788170] systemd[1]: Finished Load/Save OS Random Seed.1945worker # [ 53.793449] systemd[1]: Reached target First Boot Complete.1946worker # [ 53.800252] systemd[1]: Mounted /run/wrappers.1947worker # [ 53.806834] systemd[1]: Reached target Local File Systems.1948worker # [ 53.811385] systemd[1]: Listening on Boot Loader Control Service Socket.1949worker # [ 53.814826] systemd[1]: Starting register-nix-paths.service...1950worker # [ 53.816675] systemd[1]: Starting Create SUID/SGID Wrappers...1951worker # [ 53.820437] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1952worker # [ 53.824598] systemd[1]: Starting Save Transient machine-id to Disk...1953worker # [ 53.828578] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1954worker # [ 53.833690] systemd[1]: Finished Save Transient machine-id to Disk.1955worker # [ 53.840417] systemd[1]: Finished Firewall.1956worker # [ 53.841814] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1957worker # [ 53.845566] systemd[1]: Finished Flush Journal to Persistent Storage.1958worker # [ 53.848626] systemd[1]: Starting Create System Files and Directories...1959worker # [ 53.881702] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1960worker # [ 53.883592] systemd[1]: Finished Create SUID/SGID Wrappers.1961worker # [ 53.907184] systemd[1]: Finished Create System Files and Directories.1962worker # [ 53.917354] systemd[1]: Starting Rebuild Journal Catalog...1963worker # [ 53.926125] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1964worker # [ 53.993695] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1965worker # [ 54.044215] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1966worker # [ 54.050568] systemd[1]: Finished Rebuild Journal Catalog.1967worker # [ 54.055390] systemd[1]: Starting Update is Completed...1968worker # [ 54.104348] systemd[1]: Finished Update is Completed.1969worker # [ 54.139762] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1970worker # [ 54.167554] (udev-worker)[380]: Network interface NamePolicy= disabled on kernel command line.1971worker # [ 54.173593] (udev-worker)[388]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1972worker # [ 54.178284] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line.1973worker # [ 54.335204] systemd[1]: Condition check resulted in Virtio network device being skipped.1974worker # [ 54.337485] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1975worker # [ 54.341973] systemd[1]: Starting Create SUID/SGID Wrappers...1976worker # [ 54.343496] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1977worker # [ 54.347323] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671978worker # [ 54.352282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1979worker # [ 54.358313] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1980worker # [ 54.360671] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1981worker # [ 54.498209] systemd[1]: Finished register-nix-paths.service.1982worker # [ 54.886065] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31983worker # [ 54.932462] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1984worker # [ 54.952191] mousedev: PS/2 mouse device common for all mice1985worker # [ 54.955514] ACPI: button: Power Button [PWRF]1986worker # [ 54.731757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1987worker # [ 54.740152] systemd[1]: Finished Create SUID/SGID Wrappers.1988worker # [ 54.743208] systemd[1]: Reached target System Initialization.1989worker # [ 54.745290] systemd[1]: Started Discard unused filesystem blocks once a week.1990worker # [ 54.747237] systemd[1]: Started Daily Cleanup of Temporary Directories.1991worker # [ 54.750803] systemd[1]: Reached target Timer Units.1992worker # [ 54.756219] systemd[1]: Listening on D-Bus System Message Bus Socket.1993worker # [ 54.757698] systemd[1]: Listening on Nix Daemon Socket.1994worker # [ 54.764307] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1995worker # [ 54.766331] systemd[1]: Listening on tribuchet-agent@1.socket.1996worker # [ 54.771493] systemd[1]: Reached target Socket Units.1997worker # [ 54.781126] systemd[1]: Reached target Basic System.1998worker # [ 54.783310] systemd[1]: Started backdoor.service.1999worker # [ 54.786308] systemd[1]: Starting Import lastlog data into lastlog2 database...2000worker # [ 54.797450] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2001worker # [ 54.800259] systemd[1]: Starting Post-Boot Actions...2002worker # [ 54.808826] systemd[1]: Started Reset console on configuration changes.2003worker # [ 54.812672] systemd[1]: Starting resolvconf update...2004worker # [ 54.826583] systemd[1]: Starting D-Bus System Message Bus...2005worker # [ 54.940740] systemd[1]: Finished Post-Boot Actions.2006worker # connecting to host...2007worker # [ 54.997801] systemd[1]: Started Name Service Cache Daemon (nsncd).2008worker # [ 55.003397] systemd[1]: Reached target Host and Network Name Lookups.2009worker # [ 55.015350] nsncd[587]: Aug 30 18:06:55.808 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2010worker # [ 55.025930] systemd[1]: Reached target User and Group Name Lookups.2011worker # [ 55.027748] systemd[1]: Starting User Login Management...2012worker # [ 55.050461] systemd[1]: Finished Import lastlog data into lastlog2 database.2013worker: Guest shell says: b'Spawning backdoor root shell...\n'2014worker: connected to guest root shell2015worker: (connecting took 55.74 seconds)2016worker: (finished: waiting for the VM to finish booting, in 55.74 seconds)2017worker # [ 55.105438] dbus-broker-launch[591]: Looking up NSS user entry for 'systemd-timesync'...2018worker # [ 55.113117] dbus-broker-launch[591]: NSS returned no entry for 'systemd-timesync'2019worker # [ 55.114864] dbus-broker-launch[591]: Invalid user-name in /nix/store/acr2srp7r795sc6z2vlwnc3iicfijkxg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2020worker # [ 55.159187] systemd[1]: Started D-Bus System Message Bus.2021worker # [ 55.414728] Console: switching to colour dummy device 80x252022worker # [ 55.256915] dbus-broker-launch[591]: Ready2023worker # [ 55.507690] rtc_cmos 00:04: RTC can wake from S42024worker # [ 55.356543] systemd-logind[603]: New seat seat0.2025worker # [ 55.370441] systemd[1]: Started User Login Management.2026worker # [ 55.375406] systemd[1]: Stopped target Host and Network Name Lookups.2027worker # [ 55.377474] systemd[1]: Stopping Host and Network Name Lookups...2028worker # [ 55.389902] systemd[1]: Stopped target User and Group Name Lookups.2029worker # [ 55.393801] systemd[1]: Stopping User and Group Name Lookups...2030worker # [ 55.399400] systemd[1]: Starting linger-users.service...2031worker # [ 55.401877] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2032worker # [ 55.411866] systemd[1]: nscd.service: Deactivated successfully.2033worker # [ 55.413940] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2034worker # [ 55.418300] systemd[1]: nscd.service: Consumed 25ms CPU time over 632ms wall clock time, 6.9M memory peak, 5.5M read from disk.2035worker # [ 55.425486] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2036worker # [ 55.675347] rtc_cmos 00:04: registered as rtc02037worker # [ 55.689793] [drm] Found bochs VGA, ID 0xb0c5.2038worker # [ 55.691274] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.2039worker # [ 55.486301] systemd[1]: linger-users.service: Deactivated successfully.2040worker # [ 55.721557] rtc_cmos 00:04: setting system clock to 2026-08-30T18:06:56 UTC (1788113216)2041worker # [ 55.491168] systemd[1]: Finished linger-users.service.2042worker # [ 55.736928] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input42043worker # [ 55.515498] systemd[1]: Started Name Service Cache Daemon (nsncd).2044worker # [ 55.517962] systemd[1]: Reached target Host and Network Name Lookups.2045worker # [ 55.524072] systemd[1]: Reached target User and Group Name Lookups.2046worker # [ 55.526786] nsncd[669]: Aug 30 18:06:56.525 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2047worker # [ 55.764604] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs2048worker # [ 55.767616] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic2049worker # [ 55.768793] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 02050worker # [ 55.782560] parport_pc 00:02: reported by Plug and Play ACPI2051worker # [ 55.553434] systemd[1]: Finished resolvconf update.2052worker # [ 55.555297] systemd[1]: Reached target Preparation for Network.2053worker # [ 55.563175] systemd[1]: Starting DHCP Client...2054worker # [ 55.579230] systemd[1]: Starting Address configuration of eth1...2055worker # [ 55.584398] systemd[1]: Starting Extra networking commands....2056worker # [ 55.823311] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]2057worker # [ 55.596351] systemd[1]: Starting Tailscale node agent...2058worker # [ 55.808678] network-addresses-eth1-start[696]: adding address 192.168.1.2/24... done2059worker # [ 55.838154] network-addresses-eth1-start[696]: adding address 2001:db8:1::2/64... done2060worker # [ 55.876660] systemd[1]: Finished Address configuration of eth1.2061worker # [ 56.172553] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized2062worker # [ 56.302886] Console: switching to colour frame buffer device 160x502063worker # [ 56.342041] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device2064worker # [ 56.133983] dhcpcd[712]: dhcpcd-10.3.2 starting2065worker # [ 56.143370] dhcpcd[766]: dev: loaded udev2066worker # [ 56.394722] 8021q: 802.1Q VLAN Support v1.82067worker # [ 56.399591] 8021q: adding VLAN 0 to HW filter on device eth12068worker # [ 56.171722] tailscaled[698]: TPM: error opening: stat /dev/tpmrm0: no such file or directory2069worker # [ 56.189812] systemd[1]: Finished Extra networking commands..2070worker # [ 56.192305] systemd[1]: Reached target Network.2071worker # [ 56.203340] systemd[1]: Starting Permit User Sessions...2072worker # [ 56.244192] tailscaled[698]: Program starting: v1.102.3, Go 1.26.7: []string{"/nix/store/lfqbsp1wh59izfbs39sf9yds7dp0jwdj-tailscale-1.102.3/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}2073worker # [ 56.249632] tailscaled[698]: LogID: 0c367f3eb3d051f3b8452516528a0b6d5d6bbedfefabbe40f3ca44779a36590f2074worker # [ 56.251701] tailscaled[698]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"2075worker # [ 56.255328] tailscaled[698]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory2076worker # [ 56.262286] tailscaled[698]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil2077worker # [ 56.308828] dbus-broker-launch[591]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.2078worker # [ 56.349155] systemd[1]: Finished Permit User Sessions.2079worker # [ 56.360231] tailscaled[698]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:46505->[::1]:53: read: connection refused (in 86ms), trying bootstrap...2080worker # [ 56.408117] tailscaled[698]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ...2081worker # [ 56.414170] tailscaled[698]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable2082worker # [ 56.428160] tailscaled[698]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ...2083worker # [ 56.431373] tailscaled[698]: 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 unreachable2084worker # [ 56.437227] tailscaled[698]: trying bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" ...2085worker # [ 56.454283] systemd[1]: Started Getty on tty1.2086worker # [ 56.690830] cfg80211: Loading compiled-in X.509 certificates for regulatory database2087worker # [ 56.459778] systemd[1]: Reached target Login Prompts.2088worker # [ 56.702448] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2089worker # [ 56.704572] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2090worker # [ 56.476185] tailscaled[698]: bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.65:443: connect: network is unreachable2091worker # [ 56.714294] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22092worker # [ 56.715879] cfg80211: failed to load regulatory.db2093worker # [ 56.493463] tailscaled[698]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ...2094worker # [ 56.496360] tailscaled[698]: bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f]:443: connect: network is unreachable2095worker # [ 56.505255] tailscaled[698]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ...2096worker # [ 56.507494] tailscaled[698]: bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 45.63.71.144:443: connect: network is unreachable2097worker # [ 56.511667] tailscaled[698]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ...2098worker # [ 56.527274] tailscaled[698]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2401:c080:1000:467f:5400:2ff:feee:22aa]:443: connect: network is unreachable2099worker # [ 56.540811] tailscaled[698]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...2100worker # [ 56.543289] tailscaled[698]: 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 unreachable2101worker # [ 56.547651] tailscaled[698]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ...2102worker # [ 56.552687] tailscaled[698]: 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 unreachable2103worker # [ 56.564692] tailscaled[698]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ...2104worker # [ 56.571351] tailscaled[698]: 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 unreachable2105worker # [ 56.575828] tailscaled[698]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ...2106worker # [ 56.578826] tailscaled[698]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]2107worker # [ 56.584120] tailscaled[698]: dns: using "openresolv" mode2108worker # [ 56.590140] tailscaled[698]: dns: using dns.openresolvManager2109worker # [ 56.608898] tailscaled[698]: bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:100:d0::982:d001]:443: connect: network is unreachable2110worker # [ 56.614906] tailscaled[698]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ...2111worker # [ 56.617906] tailscaled[698]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable2112worker # [ 56.622625] tailscaled[698]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ...2113worker # [ 56.638134] tailscaled[698]: bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::e1f:4001]:443: connect: network is unreachable2114worker # [ 56.643410] tailscaled[698]: logtail: upload: log upload of 466 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/40d2f58b73d3c1501c0f03f5ef819a6d3b91446b23d362cf38bef2e86ed0a165": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"2115worker # [ 56.908308] 8021q: adding VLAN 0 to HW filter on device eth02116worker # [ 56.685136] dhcpcd[766]: eth0: waiting for carrier2117worker # [ 56.688092] dhcpcd[766]: eth0: carrier acquired2118worker # [ 56.709196] dhcpcd[766]: DUID 00:01:00:01:32:27:2d:c1:52:54:00:12:34:562119worker # [ 56.711580] dhcpcd[766]: eth0: IAID 00:12:34:562120worker # [ 56.713346] dhcpcd[766]: eth0: adding address fe80::5054:ff:fe12:34562121worker # [ 56.884222] tailscaled[698]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found2122worker # [ 56.891056] systemd[1]: Started Tailscale node agent.2123worker # [ 56.895709] tailscaled[698]: wgengine.NewUserspaceEngine(tun "tailscale0") ...2124worker # [ 57.146896] tun: Universal TUN/TAP device driver, 1.62125worker # [ 57.159551] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt2126worker # [ 57.161714] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD2127worker # [ 57.028875] tailscaled[698]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]2128worker # [ 57.032754] tailscaled[698]: dns: using "openresolv" mode2129worker # [ 57.049510] tailscaled[698]: dns: using dns.openresolvManager2130worker # [ 57.052153] tailscaled[698]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true}2131worker # [ 57.065605] tailscaled[698]: router: portUpdate(port=41641, network=udp6)2132worker # [ 57.069218] tailscaled[698]: router: using firewall mode pref2133worker # [ 57.082160] tailscaled[698]: magicsock: disco key = d:5d2701f89d815c262134worker # [ 57.087394] tailscaled[698]: Creating WireGuard device...2135worker # [ 57.088791] tailscaled[698]: Bringing WireGuard device up...2136worker # [ 57.090382] tailscaled[698]: Bringing router up...2137worker # [ 57.326222] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input62138worker # [ 57.328457] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input52139worker # [ 57.135115] tailscaled[698]: external route: up2140worker # [ 57.154378] tailscaled[698]: router: default choosing iptables2141worker # [ 57.193537] tailscaled[698]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true2142worker # [ 57.196984] tailscaled[698]: router: portUpdate(port=41641, network=udp4)2143worker # [ 57.209401] tailscaled[698]: Clearing router settings...2144worker # [ 57.212726] tailscaled[698]: Starting network monitor...2145worker # [ 57.215192] tailscaled[698]: Engine created.2146worker # [ 57.243329] systemd[1]: Starting Virtual Console Setup...2147worker # [ 57.320735] systemd-logind[603]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)2148worker # [ 57.333814] systemd-logind[603]: Watching system buttons on /dev/input/event2 (Power Button)2149worker # [ 57.399113] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2150worker # [ 57.405222] systemd[1]: Stopped Virtual Console Setup.2151worker # [ 57.418187] systemd[1]: Starting Virtual Console Setup...2152worker # [ 57.705740] ppdev: user-space parallel port driver2153worker # [ 57.528691] systemd-vconsole-setup[851]: Configuration of first virtual console was skipped, ignoring remaining ones.2154worker # [ 57.538237] systemd[1]: Finished Virtual Console Setup.2155worker # [ 57.544354] systemd-logind[603]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2156worker # [ 57.560206] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2157worker # [ 57.565194] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2158worker # [ 57.568563] systemd[1]: Stopped Virtual Console Setup.2159worker # [ 57.570208] systemd[1]: Stopping Virtual Console Setup...2160worker # [ 57.575425] systemd[1]: Starting Virtual Console Setup...2161worker # [ 57.584229] (udev-worker)[798]: Network interface NamePolicy= disabled on kernel command line.2162worker # [ 57.829156] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)2163worker # [ 57.638679] systemd-vconsole-setup[855]: Configuration of first virtual console was skipped, ignoring remaining ones.2164worker # [ 57.647265] systemd[1]: Finished Virtual Console Setup.2165worker # [ 57.891429] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)2166worker: (finished: waiting for unit tailscaled, in 58.37 seconds)2167hub: must succeed: headscale users create test2168worker # [ 58.041276] kvm_amd: TSC scaling supported2169worker # [ 58.041867] kvm_amd: Nested Virtualization enabled2170worker # [ 58.043239] kvm_amd: Nested Paging enabled2171worker # [ 58.043827] kvm_amd: LBR virtualization supported2172worker # [ 58.044910] kvm_amd: Virtual VMLOAD VMSAVE supported2173worker # [ 58.045982] kvm_amd: Virtual GIF supported2174worker # [ 58.078485] EDAC MC: Ver: 3.0.02175hub # [ 185.206636] headscale-start[877]: 2026-08-30T18:06:58Z INF user created user.name=test2176hub: (finished: must succeed: headscale users create test, in 0.24 seconds)2177hub: must succeed: headscale preauthkeys -u 1 create --reusable2178worker # [ 58.056191] dhcpcd[766]: eth0: soliciting a DHCP lease2179worker # [ 58.117750] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2180worker # [ 58.371687] NET: Registered PF_PACKET protocol family2181worker # [ 58.150970] dhcpcd[766]: eth0: offered 10.0.2.15 from 10.0.2.22182worker # [ 58.154431] dhcpcd[766]: eth0: probing address 10.0.2.15/242183hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.45 seconds)2184hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ALD49gnbVi06-PO9Gbdj-2h1Ng1rQ6-SOTp9AYLROxWj9rE_02vVH2WTht9GjFkibN-AMQqYEat2m --hostname hub2185hub # [ 185.845444] tailscaled[660]: localapi: [POST] /localapi/v0/check-prefs2186hub # [ 185.850081] tailscaled[660]: localapi: [POST] /localapi/v0/start2187hub # [ 185.851674] tailscaled[660]: control: client.Shutdown ...2188hub # [ 185.853269] tailscaled[660]: control: mapRoutine: exiting2189hub # [ 185.854758] tailscaled[660]: control: authRoutine: exiting2190hub # [ 185.856173] tailscaled[660]: control: updateRoutine: exiting2191hub # [ 185.861271] tailscaled[660]: control: Client.Shutdown done.2192hub # [ 185.863375] tailscaled[660]: Start2193hub # [ 185.872157] tailscaled[660]: 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]2194hub # [ 185.876910] tailscaled[660]: generating new machine key2195worker # [ 58.926361] dhcpcd[766]: eth0: soliciting an IPv6 router2196worker # [ 58.928600] dhcpcd[766]: eth0: Router Advertisement from fe80::22197worker # [ 58.930242] dhcpcd[766]: eth0: adding address fec0::5054:ff:fe12:3456/642198worker # [ 58.932217] dhcpcd[766]: eth0: adding route to fec0::/642199worker # [ 58.934256] dhcpcd[766]: eth0: adding default route via fe80::22200worker # [ 58.936115] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2542201worker # [ 58.938764] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2542202worker # [ 58.941660] tailscaled[698]: 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::4530:a7b1:7f94:7e8d/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::4530:a7b1:7f94:7e8d/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed]2203worker # [ 58.951224] tailscaled[698]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::4530:a7b1:7f94:7e8d/64 fec0::5054:ff:fe12:3456/64]2204worker # [ 58.954589] tailscaled[698]: magicsock: 0 active derp conns2205worker # [ 58.956996] tailscaled[698]: router: portUpdate(port=41641, network=udp6)2206worker # [ 58.958785] tailscaled[698]: router: portUpdate(port=41641, network=udp4)2207worker # [ 59.118490] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2208worker # [ 60.119717] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2209worker # [ 60.349372] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552210worker # [ 60.924986] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=fec0::4530:a7b1:7f94:7e8d/128, gw=, outif=2, table=2552211worker # [ 61.120628] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2212worker # [ 62.125114] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2213worker # [ 62.127574] tailscaled[698]: [RATELIMIT] format("tstun: tstun: awaiting Wrapper.Start call")2214worker # [ 62.683143] dhcpcd[766]: eth0: leased 10.0.2.15 for 86400 seconds2215worker # [ 62.685454] dhcpcd[766]: eth0: adding route to 10.0.2.0/242216worker # [ 62.688859] dhcpcd[766]: eth0: adding default route via 10.0.2.22217worker # [ 62.690527] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552218worker # [ 62.692723] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552219worker # [ 62.694988] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542220worker # [ 62.701590] tailscaled[698]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::4530:a7b1:7f94:7e8d/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::4530:a7b1:7f94:7e8d/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::4530:a7b1:7f94:7e8d/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::4530:a7b1:7f94:7e8d/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed]2221worker # [ 62.714631] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542222worker # [ 62.718376] tailscaled[698]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::4530:a7b1:7f94:7e8d/64 fec0::5054:ff:fe12:3456/64]2223worker # [ 62.721122] tailscaled[698]: magicsock: 0 active derp conns2224worker # [ 62.725959] tailscaled[698]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152225worker # [ 62.731875] tailscaled[698]: router: portUpdate(port=41641, network=udp6)2226worker # [ 62.735232] tailscaled[698]: router: portUpdate(port=41641, network=udp4)2227worker # [ 62.744360] tailscaled[698]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2228worker # [ 62.792410] systemd[1]: Started DHCP Client.2229worker # [ 62.795431] systemd[1]: Reached target Multi-User System.2230worker # [ 62.797359] systemd[1]: Startup finished in 1.312s (kernel) + 40.275s (initrd) + 21.208s (userspace) = 1min 2.796s.2231worker # [ 68.131722] tailscaled[698]: [RATELIMIT] format("tstun: tstun: awaiting Wrapper.Start call") (5 dropped)2232worker # [ 68.133969] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2233worker # [ 69.131933] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call2234worker # [ 69.133716] tailscaled[698]: [RATELIMIT] format("tstun: tstun: awaiting Wrapper.Start call")2235hub # [ 198.539892] tailscaled[660]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on 10.0.2.3:53: read udp 10.0.2.15:60655->10.0.2.3:53: i/o timeout (in 10.002s), trying bootstrap...2236worker # [ 76.575943] tailscaled[698]: pm: migrating "_daemon" profile to new format2237worker # [ 76.649466] tailscaled[698]: envknob: PORT="41641"2238hub # [ 203.946993] tailscaled[660]: machine key written to store2239hub # [ 203.984963] tailscaled[660]: profile data directory: profile not found2240hub # [ 203.986947] tailscaled[660]: Backend: logs: be:ffc315636e6a75cc80db01f889b2957b18459eb86077209d1b728a42152a19e9 fe:2241hub # [ 204.000792] tailscaled[660]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2242hub # [ 204.003874] tailscaled[660]: blockEngineUpdates(true)2243hub # [ 204.010257] tailscaled[660]: Reconfig(down): no changes made to Engine config2244worker # [ 76.661860] tailscaled[698]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"2245hub # [ 204.030458] tailscaled[660]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2246hub # [ 204.042609] tailscaled[660]: health(warnable=wantrunning-false): ok2247worker # [ 76.718115] tailscaled[698]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes2248hub # [ 204.055553] tailscaled[660]: localapi: [POST] /localapi/v0/login-interactive2249hub # [ 204.057246] tailscaled[660]: StartLoginInteractiveAs("root"): url=false2250hub # [ 204.058695] tailscaled[660]: control: client.Login(2)2251hub # [ 204.069202] tailscaled[660]: control: LoginInteractive -> regen=true2252hub # [ 204.071347] tailscaled[660]: control: doLogin(regen=true, hasUrl=false)2253worker # [ 76.730700] tailscaled[698]: got LocalBackend in 19.829s2254worker # [ 76.766601] tailscaled[698]: Start2255worker # [ 76.770136] tailscaled[698]: ipnext: "conn25": skipping extension2256worker # [ 76.791824] tailscaled[698]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop2257worker # [ 76.808136] tailscaled[698]: profile data directory: profile not found2258worker # [ 76.810433] tailscaled[698]: Backend: logs: be:0c367f3eb3d051f3b8452516528a0b6d5d6bbedfefabbe40f3ca44779a36590f fe:2259worker # [ 76.813127] tailscaled[698]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)2260worker # [ 76.816291] tailscaled[698]: blockEngineUpdates(true)2261worker # [ 76.818723] tailscaled[698]: wgengine: Reconfig: configuring router2262worker # [ 76.820939] tailscaled[698]: wgengine: Reconfig: user dialer2263worker # [ 76.822629] tailscaled[698]: wgengine: Reconfig: configuring DNS2264worker # [ 76.824494] tailscaled[698]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2265worker # [ 76.826769] tailscaled[698]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2266worker # [ 76.828813] tailscaled[698]: health(warnable=wantrunning-false): error: Tailscale is stopped.2267worker # [ 76.830991] tailscaled[698]: dns: OScfg: {}2268hub # [ 204.182931] tailscaled[660]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2269hub # [ 204.209661] headscale-start[877]: 2026-08-30T18:07:17Z INF http request bytes=176 elapsed=4.464813 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:42678 status=2002270hub # [ 204.218816] tailscaled[660]: control: control server key from https://hub: ts2021=[qFhKG], legacy=2271hub # [ 204.222610] tailscaled[660]: control: Generating a new nodekey.2272hub # [ 204.229980] tailscaled[660]: control: RegisterReq: onode= node=[SrAB0] fup=false nks=false2273hub # [ 205.083235] headscale-start[877]: 2026-08-30T18:07:18Z INF http request bytes=249 elapsed=822.110631 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:42692 status=2002274hub # [ 205.093335] tailscaled[660]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2275hub # [ 205.102838] tailscaled[660]: blockEngineUpdates(false)2276hub # [ 205.586128] headscale-start[877]: 2026-08-30T18:07:18Z INF http request bytes=0 elapsed=482.484226 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42692 status=2002277hub # [ 206.083514] headscale-start[877]: 2026-08-30T18:07:19Z INF node connected machine.key=[fKcGY] node.expired=false node.id=1 node.is_tagged=false node.key=[SrAB0] node.name=hub node.online=true user.name=test2278hub # [ 206.099892] headscale-start[877]: 2026-08-30T18:07:19Z INF github.com/juanfont/headscale/hscontrol/poll.go:250 > node has connected chan=0x2bd27c9b5c00 component=poll machine.key=[fKcGY] node.expired=false node.id=1 node.is_tagged=false node.key=[SrAB0] node.name=hub node.online=false omit_peers=false stream=true user.name=test2279hub # [ 206.323755] tailscaled[660]: magicsock: new contact: control-netmap usec=152238962 cached=false2280hub # [ 206.327230] tailscaled[660]: active login: test2281hub # [ 206.365178] tailscaled[660]: netmap: suggested exit node: no preferred DERP, try again later2282hub # [ 206.369714] tailscaled[660]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2283hub # [ 206.374203] tailscaled[660]: magicsock: SetPrivateKey called (init)2284hub # [ 206.376805] tailscaled[660]: wgengine: Reconfig: configuring router2285hub # [ 206.607783] tailscaled[660]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [26ms] (forced=false)2286hub # [ 206.610584] tailscaled[660]: magicsock: home is now derp-999 ()2287hub # [ 206.614530] tailscaled[660]: 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::1e5:f170:95c9:828d]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local)2288hub # [ 206.619894] tailscaled[660]: magicsock: adding connection to derp-999 for home-keep-alive2289hub # [ 206.626665] tailscaled[660]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2290hub # [ 206.629226] tailscaled[660]: derphttp.Client.Connect: connecting to derp-999 ()2291hub # [ 206.640204] tailscaled[660]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2292hub # [ 206.674436] tailscaled[660]: magicsock: derp-999 connected; connGen=12293hub # [ 207.349128] tailscaled[660]: router: enabling connmark-based rp_filter workaround2294hub # [ 207.552951] tailscaled[660]: wgengine: Reconfig: user dialer2295hub # [ 207.556392] tailscaled[660]: tsdial: bart table size: 22296hub # [ 207.559431] tailscaled[660]: wgengine: Reconfig: configuring DNS2297hub # [ 207.561077] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2298hub # [ 207.716648] tailscaled[660]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2299hub # [ 207.719642] tailscaled[660]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2300hub # [ 207.895871] systemd[1]: Stopped target Host and Network Name Lookups.2301hub # [ 207.901858] systemd[1]: Stopping Host and Network Name Lookups...2302hub # [ 207.907136] systemd[1]: Stopped target User and Group Name Lookups.2303hub # [ 207.909330] systemd[1]: Stopping User and Group Name Lookups...2304hub # [ 207.913458] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2305hub # [ 207.937383] systemd[1]: nscd.service: Deactivated successfully.2306hub # [ 207.946210] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2307hub # [ 207.982782] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2308hub # [ 208.066166] tailscaled[660]: peerapi: serving on http://100.64.0.1:584362309hub # [ 208.069412] tailscaled[660]: peerapi: serving on http://[fd7a:115c:a1e0::1]:597802310hub # [ 208.083825] tailscaled[660]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2311hub # [ 208.088352] tailscaled[660]: updating netmap in disk cache2312hub # [ 208.099383] headscale-start[877]: 2026-08-30T18:07:21Z INF http request bytes=0 elapsed=13.972726 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42692 status=2002313hub # [ 208.105658] tailscaled[660]: health(warnable=warming-up): ok2314hub # [ 208.111133] tailscaled[660]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2315hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ALD49gnbVi06-PO9Gbdj-2h1Ng1rQ6-SOTp9AYLROxWj9rE_02vVH2WTht9GjFkibN-AMQqYEat2m --hostname hub, in 22.40 seconds)2316worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ALD49gnbVi06-PO9Gbdj-2h1Ng1rQ6-SOTp9AYLROxWj9rE_02vVH2WTht9GjFkibN-AMQqYEat2m --hostname tt-worker2317hub # [ 208.162260] nsncd[1040]: Aug 30 18:07:21.293 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2318hub # [ 208.167952] systemd[1]: Started Name Service Cache Daemon (nsncd).2319hub # [ 208.172932] systemd[1]: Reached target Host and Network Name Lookups.2320hub # [ 208.175694] systemd[1]: Reached target User and Group Name Lookups.2321worker # [ 80.863569] tailscaled[698]: localapi: [POST] /localapi/v0/check-prefs2322worker # [ 80.866558] tailscaled[698]: localapi: [POST] /localapi/v0/start2323worker # [ 80.868597] tailscaled[698]: control: client.Shutdown ...2324worker # [ 80.870064] tailscaled[698]: control: mapRoutine: exiting2325worker # [ 80.872130] tailscaled[698]: control: authRoutine: exiting2326worker # [ 80.873966] tailscaled[698]: control: updateRoutine: exiting2327worker # [ 80.878242] tailscaled[698]: control: Client.Shutdown done.2328worker # [ 80.880717] tailscaled[698]: Start2329worker # [ 80.883924] tailscaled[698]: 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]2330worker # [ 80.893933] tailscaled[698]: generating new machine key2331hub # [ 208.540452] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...2332hub # [ 208.544116] tailscaled[660]: 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 unreachable2333hub # [ 208.548618] tailscaled[660]: trying bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" ...2334hub # [ 208.597243] headscale-start[877]: 2026-08-30T18:07:21Z INF http request bytes=0 elapsed=460.397062 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42692 status=2002335hub # [ 209.278815] tailscaled[660]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2336hub # [ 211.550139] tailscaled[660]: bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2337hub # [ 211.554819] tailscaled[660]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ...2338hub # [ 211.557354] tailscaled[660]: bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 207.148.3.137:443: connect: network is unreachable2339hub # [ 211.567477] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...2340hub # [ 214.567993] tailscaled[660]: 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": context deadline exceeded2341hub # [ 214.572733] tailscaled[660]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ...2342hub # [ 214.575282] tailscaled[660]: bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 46.101.74.201:443: connect: network is unreachable2343hub # [ 214.579208] tailscaled[660]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ...2344hub # [ 217.583186] tailscaled[660]: bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2345hub # [ 217.588511] tailscaled[660]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ...2346hub # [ 217.591864] tailscaled[660]: 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 unreachable2347hub # [ 217.595971] tailscaled[660]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ...2348hub # [ 220.593615] tailscaled[660]: bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2349hub # [ 220.597689] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...2350hub # [ 220.600653] tailscaled[660]: 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 unreachable2351hub # [ 220.604591] tailscaled[660]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ...2352hub # [ 223.608489] tailscaled[660]: 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": context deadline exceeded2353hub # [ 223.613298] tailscaled[660]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...2354hub # [ 223.616686] tailscaled[660]: 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 unreachable2355hub # [ 223.620942] tailscaled[660]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ...2356hub # [ 226.625366] tailscaled[660]: bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2357worker # [ 102.655421] tailscaled[698]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on 10.0.2.3:53: read udp 10.0.2.15:53308->10.0.2.3:53: i/o timeout (in 10.003s), trying bootstrap...2358worker # [ 112.657513] tailscaled[698]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ...2359worker # [ 112.660690] tailscaled[698]: bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 45.63.71.144:443: connect: network is unreachable2360worker # [ 112.664764] tailscaled[698]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ...2361worker # [ 115.668313] tailscaled[698]: bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2362worker # [ 115.673784] tailscaled[698]: trying bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" ...2363worker # [ 115.676861] tailscaled[698]: bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 149.28.119.105:443: connect: network is unreachable2364worker # [ 115.681680] tailscaled[698]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ...2365worker # [ 118.678085] tailscaled[698]: bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2366worker # [ 118.681793] tailscaled[698]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ...2367worker # [ 118.684306] tailscaled[698]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable2368worker # [ 118.688186] tailscaled[698]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ...2369worker # [ 119.209205] tailscaled[698]: machine key written to store2370worker # [ 119.210561] tailscaled[698]: profile data directory: profile not found2371worker # [ 119.211830] tailscaled[698]: Backend: logs: be:0c367f3eb3d051f3b8452516528a0b6d5d6bbedfefabbe40f3ca44779a36590f fe:2372worker # [ 119.215450] tailscaled[698]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2373worker # [ 119.218790] tailscaled[698]: blockEngineUpdates(true)2374worker # [ 119.220242] tailscaled[698]: Reconfig(down): no changes made to Engine config2375worker # [ 119.223421] tailscaled[698]: localapi: [POST] /localapi/v0/login-interactive2376worker # [ 119.226423] tailscaled[698]: StartLoginInteractiveAs("root"): url=false2377worker # [ 119.228821] tailscaled[698]: control: client.Login(2)2378worker # [ 119.235181] tailscaled[698]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2379worker # [ 119.237407] tailscaled[698]: health(warnable=wantrunning-false): ok2380worker # [ 119.238781] tailscaled[698]: control: LoginInteractive -> regen=true2381worker # [ 119.240937] tailscaled[698]: control: doLogin(regen=true, hasUrl=false)2382worker # [ 119.600209] tailscaled[698]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2383worker # [ 119.604690] tailscaled[698]: control: control server key from https://hub: ts2021=[qFhKG], legacy=2384hub # [ 246.931311] headscale-start[877]: 2026-08-30T18:08:00Z INF http request bytes=176 elapsed=0.478832 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:52990 status=2002385worker # [ 119.606936] tailscaled[698]: control: Generating a new nodekey.2386worker # [ 119.611112] tailscaled[698]: control: RegisterReq: onode= node=[/cB+u] fup=false nks=false2387worker # [ 120.502542] tailscaled[698]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2388hub # [ 247.827565] headscale-start[877]: 2026-08-30T18:08:00Z INF http request bytes=249 elapsed=877.465711 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:52992 status=2002389worker # [ 120.506997] tailscaled[698]: blockEngineUpdates(false)2390hub # [ 248.335905] headscale-start[877]: 2026-08-30T18:08:01Z INF http request bytes=0 elapsed=500.012711 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:52992 status=2002391hub # [ 248.510150] tailscaled[660]: wgengine: Reconfig: configuring router2392hub # [ 248.513722] tailscaled[660]: wgengine: Reconfig: user dialer2393hub # [ 248.515894] tailscaled[660]: tsdial: bart table size: 42394hub # [ 248.517887] tailscaled[660]: wgengine: Reconfig: configuring DNS2395hub # [ 248.519274] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2396hub # [ 248.568623] tailscaled[660]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2397hub # [ 248.572744] tailscaled[660]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2398hub # [ 248.776345] tailscaled[660]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2399hub # [ 248.830927] headscale-start[877]: 2026-08-30T18:08:01Z INF http request bytes=0 elapsed=50.313657 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42692 status=2002400hub # [ 248.836468] headscale-start[877]: 2026-08-30T18:08:01Z INF node connected machine.key=[9LyFX] node.expired=false node.id=2 node.is_tagged=false node.key=[/cB+u] node.name=tt-worker node.online=true user.name=test2401hub # [ 248.840302] headscale-start[877]: 2026-08-30T18:08:01Z INF github.com/juanfont/headscale/hscontrol/poll.go:250 > node has connected chan=0x2bd27c9f23f0 component=poll machine.key=[9LyFX] node.expired=false node.id=2 node.is_tagged=false node.key=[/cB+u] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test2402worker # [ 121.685647] tailscaled[698]: bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2403worker # [ 121.691198] tailscaled[698]: trying bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" ...2404worker # [ 121.695548] tailscaled[698]: bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 165.22.33.71:443: connect: network is unreachable2405worker # [ 121.699660] tailscaled[698]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ...2406hub # [ 249.282051] tailscaled[660]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2407worker # [ 124.696503] tailscaled[698]: 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": context deadline exceeded2408worker # [ 124.699940] tailscaled[698]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...2409worker # [ 124.702313] tailscaled[698]: 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 unreachable2410worker # [ 124.706299] tailscaled[698]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ...2411worker # [ 126.953170] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (5.000798145s elapsed)2412worker # [ 127.703935] tailscaled[698]: bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2413worker # [ 127.708270] tailscaled[698]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ...2414worker # [ 127.710558] tailscaled[698]: bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.179.66:443: connect: network is unreachable2415worker # [ 127.714621] tailscaled[698]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ...2416worker # [ 130.715690] tailscaled[698]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2417worker # [ 131.956266] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (10.003739859s elapsed)2418worker # [ 136.956724] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (15.004036265s elapsed)2419hub # [ 266.697225] headscale-start[877]: 2026-08-30T18:08:19Z INF http request bytes=0 elapsed=60024.419018 method=GET path=/derp proto=HTTP/1.1 remote=127.0.0.1:42704 status=02420hub # [ 266.708547] tailscaled[660]: magicsock: [0x1e3c1f283340] derp.Recv(derp-999): derp.Recv: EOF2421hub # [ 266.730521] tailscaled[660]: derphttp.Client.Recv: connecting to derp-999 ()2422hub # [ 266.751165] tailscaled[660]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2423hub # [ 266.804406] tailscaled[660]: magicsock: derp-999 connected; connGen=22424worker # [ 141.960443] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (20.007961344s elapsed)2425worker # [ 146.198571] tailscaled[698]: magicsock: new contact: control-netmap usec=89139240 cached=false2426worker # [ 146.201375] tailscaled[698]: active login: test2427worker # [ 146.250184] tailscaled[698]: netmap: suggested exit node: no preferred DERP, try again later2428worker # [ 146.253408] tailscaled[698]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2429worker # [ 146.255688] tailscaled[698]: magicsock: SetPrivateKey called (init)2430worker # [ 146.258120] tailscaled[698]: wgengine: Reconfig: configuring router2431worker # [ 146.458697] tailscaled[698]: router: enabling connmark-based rp_filter workaround2432worker # [ 146.462211] tailscaled[698]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [2ms] (forced=false)2433worker # [ 146.467148] tailscaled[698]: magicsock: home is now derp-999 ()2434worker # [ 146.468695] tailscaled[698]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::4530:a7b1:7f94:7e8d]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local)2435worker # [ 146.473189] tailscaled[698]: magicsock: adding connection to derp-999 for home-keep-alive2436worker # [ 146.475318] tailscaled[698]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2437worker # [ 146.477989] tailscaled[698]: derphttp.Client.Connect: connecting to derp-999 ()2438worker # [ 146.487679] tailscaled[698]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2439worker # [ 146.497975] tailscaled[698]: magicsock: derp-999 connected; connGen=12440worker # [ 146.513163] tailscaled[698]: wgengine: Reconfig: user dialer2441worker # [ 146.515327] tailscaled[698]: tsdial: bart table size: 42442worker # [ 146.516557] tailscaled[698]: wgengine: Reconfig: configuring DNS2443worker # [ 146.518194] tailscaled[698]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2444worker # [ 146.537856] tailscaled[698]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2445worker # [ 146.540425] tailscaled[698]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2446worker # [ 146.586955] systemd[1]: Stopped target Host and Network Name Lookups.2447worker # [ 146.590890] systemd[1]: Stopping Host and Network Name Lookups...2448worker # [ 146.593670] systemd[1]: Stopped target User and Group Name Lookups.2449worker # [ 146.597873] systemd[1]: Stopping User and Group Name Lookups...2450worker # [ 146.601403] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2451worker # [ 146.603723] systemd[1]: nscd.service: Deactivated successfully.2452worker # [ 146.607944] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2453worker # [ 146.628367] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2454worker # [ 146.647666] tailscaled[698]: peerapi: serving on http://100.64.0.2:465902455worker # [ 146.652109] tailscaled[698]: peerapi: serving on http://[fd7a:115c:a1e0::2]:471662456worker # [ 146.653518] tailscaled[698]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2457worker # [ 146.659485] tailscaled[698]: health(warnable=warming-up): ok2458worker # [ 146.663307] tailscaled[698]: updating netmap in disk cache2459worker # [ 146.672819] tailscaled[698]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2460worker # [ 146.686955] systemd[1]: Started Name Service Cache Daemon (nsncd).2461worker # [ 146.692079] systemd[1]: Reached target Host and Network Name Lookups.2462worker # [ 146.693644] systemd[1]: Reached target User and Group Name Lookups.2463worker # [ 146.701325] nsncd[1061]: Aug 30 18:08:27.710 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2464worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ALD49gnbVi06-PO9Gbdj-2h1Ng1rQ6-SOTp9AYLROxWj9rE_02vVH2WTht9GjFkibN-AMQqYEat2m --hostname tt-worker, in 65.89 seconds)2465??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.2466 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 392467worker: waiting for success: tailscale ping hub2468??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.2469 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 392470worker # [ 146.749275] tailscaled[698]: localapi: [POST] /localapi/v0/ping2471worker # [ 146.750715] tailscaled[698]: ping(100.64.0.1): sending disco ping to [SrAB0] hub ...2472worker # [ 146.753400] tailscaled[698]: magicsock: disco: node [SrAB0] d:2e9d1052a7d56760 now using [2001:db8:1::1]:41641 mtu=1360 tx=50aa36b61bec2473worker # [ 146.757475] tailscaled[698]: magicsock: new contact: peer=[SrAB0] usec=89701055 cached=false via=direct2474worker: (finished: waiting for success: tailscale ping hub, in 0.06 seconds)2475hub: must succeed: tailscale ip -42476hub: (finished: must succeed: tailscale ip -4, in 0.12 seconds)2477worker: 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.toml2478worker # [ 146.928731] tailscaled[698]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2479worker: (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.07 seconds)2480hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub2481hub # [ 274.481729] headscale-start[877]: 2026-08-30T18:08:27Z INF http request bytes=0 elapsed=482.902157 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:52992 status=2002482hub # [ 274.515953] systemd[1]: Starting tribuchet-hub.socket...2483hub # [ 274.549209] systemd[1]: Listening on tribuchet-hub.socket.2484hub # [ 274.570094] systemd[1]: Starting tribuchet-hub.service...2485hub # [ 274.741697] tribuchet[1081]: 2026-08-30T18:08:27.871974Z INFO tribuchet::hub::serve: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[]2486hub # [ 274.752399] tribuchet[1081]: 2026-08-30T18:08:27.881817Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true2487hub # [ 274.771618] tribuchet[1081]: 2026-08-30T18:08:27.904073Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock2488hub # [ 274.778921] systemd[1]: Started tribuchet-hub.service.2489hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.69 seconds)2490worker: must succeed: systemctl start tribuchet-worker2491hub # [ 274.983171] headscale-start[877]: 2026-08-30T18:08:28Z INF http request bytes=0 elapsed=475.249787 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:52992 status=2002492worker # [ 147.679237] systemd[1]: Starting tribuchet-worker.service...2493worker # [ 147.760717] tribuchet[1096]: 2026-08-30T18:08:28.771894Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet/worker", 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, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: ["/run/tribuchet/agents/1.sock"], spawn_agents: 0, agent_uid_base: None }2494worker # [ 147.773126] tribuchet[1096]: 2026-08-30T18:08:28.784288Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox")2495worker # [ 147.778586] systemd[1]: Started tribuchet-worker.service.2496worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.14 seconds)2497hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"'2498worker # [ 147.788888] systemd[1]: Started tribuchet-agent@1.service.2499worker # [ 147.814560] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:28.825726Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362500worker # [ 147.819748] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:28.831134Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2501worker # [ 147.824242] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:28.831198Z INFO tribuchet::worker::agent: agent listening uid=9952502hub # [ 275.171607] tailscaled[660]: magicsock: disco: node [/cB+u] d:5d2701f89d815c26 now using [2001:db8:1::2]:41641 mtu=1360 tx=482d1389c85e2503hub # [ 275.174835] tailscaled[660]: magicsock: new contact: peer=[/cB+u] usec=221086550 cached=false via=direct2504hub # [ 275.207138] tribuchet[1081]: 2026-08-30T18:08:28.339476Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }]2505worker # [ 147.911482] tribuchet[1096]: 2026-08-30T18:08:28.922918Z INFO tribuchet::worker::session: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"]2506hub # [ 275.588214] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2507hub # [ 275.590353] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2508hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.18 seconds)2509subtest: a build dispatches over the tailnet2510hub: must succeed: echo tailscale-auth-payload > /root/payload2511hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.08 seconds)2512hub: must succeed: nix-store --add /root/payload2513worker # [ 149.751129] tailscaled[698]: magicsock: disco: node [SrAB0] d:2e9d1052a7d56760 now using 192.168.1.1:41641 mtu=1360 tx=623898a552762514hub # [ 277.083763] tailscaled[660]: magicsock: disco: node [/cB+u] d:5d2701f89d815c26 now using 192.168.1.2:41641 mtu=1360 tx=f692b5afb89d2515hub # [ 280.580657] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2516hub # [ 280.582905] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2517hub # [ 297.321261] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2518hub # [ 297.325543] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2519hub # [ 297.329333] tailscaled[660]: [RATELIMIT] format("dns udp query: %v")2520hub # [ 297.338796] tailscaled[660]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [fd7a:115c:a1e0::53]:53: read udp [fd7a:115c:a1e0::1]:34678->[fd7a:115c:a1e0::53]:53: i/o timeout (in 20.009s), trying bootstrap...2521hub # [ 297.346165] tailscaled[660]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2522hub # [ 297.485973] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ...2523hub # [ 297.488959] tailscaled[660]: [RATELIMIT] format("dns udp query: %v") (2 dropped)2524hub # [ 297.498487] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2525hub # [ 297.500632] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2526hub # [ 297.502529] tailscaled[660]: 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 unreachable2527hub # [ 297.506381] tailscaled[660]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ...2528hub # [ 297.509569] headscale-start[877]: 2026-08-30T18:08:42Z INF http request bytes=0 elapsed=406.211404 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:42692 status=2002529hub # [ 298.589215] tailscaled[660]: bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2530hub # [ 298.594944] tailscaled[660]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ...2531hub # [ 298.597921] tailscaled[660]: 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 unreachable2532hub # [ 298.601966] tailscaled[660]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ...2533worker # [ 171.445372] tailscaled[698]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2534hub # [ 299.021351] headscale-start[877]: 2026-08-30T18:08:52Z INF http request bytes=0 elapsed=244.816869 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:52992 status=2002535hub: (finished: must succeed: nix-store --add /root/payload, in 23.43 seconds)2536hub: must succeed: cat > /root/test.nix << 'EOF'2537let2538 bash = builtins.storePath "/nix/store/7a60q5dgnv6z96c279rc1nalyiw4mgqn-bash-interactive-5.3p15";2539 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2540in derivation {2541 name = "tt-tailscale";2542 system = "x86_64-linux";2543 builder = bash + "/bin/bash";2544 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2545}2546EOF2547hub: (finished: must succeed: cat > /root/test.nix << 'EOF'2548let2549 bash = builtins.storePath "/nix/store/7a60q5dgnv6z96c279rc1nalyiw4mgqn-bash-interactive-5.3p15";2550 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2551in derivation {2552 name = "tt-tailscale";2553 system = "x86_64-linux";2554 builder = bash + "/bin/bash";2555 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2556}2557EOF, in 0.04 seconds)2558hub: must succeed: nix-build /root/test.nix --no-out-link2559hub # this derivation will be built:2560hub # /nix/store/cvz23131m26jpbalbxk88f5sds5xnfkc-tt-tailscale.drv2561hub # building '/nix/store/cvz23131m26jpbalbxk88f5sds5xnfkc-tt-tailscale.drv'...2562hub # [ 300.293080] tribuchet[1081]: 2026-08-30T18:08:53.424902Z INFO tribuchet::hub::submit: queueing build id="32c9671be459ece7e8f25ecf1e6842a3" system="x86_64-linux"2563hub # [ 300.297197] tribuchet[1081]: 2026-08-30T18:08:53.429611Z INFO tribuchet::hub: dispatching build id="32c9671be459ece7e8f25ecf1e6842a3" worker="tt-worker"2564hub # tribuchet: building on tt-worker2565worker # [ 172.982603] tribuchet[1096]: 2026-08-30T18:08:53.991869Z INFO tribuchet::worker::session: build assigned id="32c9671be459ece7e8f25ecf1e6842a3"2566worker # [ 172.989892] systemd[1]: Started Nix Daemon.2567worker # [ 173.030876] nix-daemon[1103]: accepted connection from pid 1096, user tribuchet (trusted)2568hub # [ 300.368592] tribuchet[1081]: 2026-08-30T18:08:53.500942Z INFO tribuchet::hub::relay::staging: input path negotiation done id="32c9671be459ece7e8f25ecf1e6842a3" total=8 missing=12569hub # [ 300.381627] systemd[1]: Started Nix Daemon.2570hub # [ 300.532728] nix-daemon[1119]: accepted connection from pid 1081, user root (trusted)2571worker # [ 173.243519] nix-daemon[1103]: accepted connection from pid 1096, user tribuchet (trusted)2572hub # [ 300.589896] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2573hub # [ 300.592906] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2574hub # [ 300.595456] tailscaled[660]: [RATELIMIT] format("dns udp query: %v")2575hub # [ 301.606370] tailscaled[660]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2576hub # [ 301.610825] tailscaled[660]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ...2577hub # [ 301.613334] tailscaled[660]: 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 unreachable2578hub # [ 301.617059] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...2579worker # [ 174.395702] tribuchet[1096]: 2026-08-30T18:08:55.406145Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="32c9671be459ece7e8f25ecf1e6842a3" fixed_output=false network=false net_isolation=false2580worker # [ 174.412823] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:55.423929Z INFO tribuchet::worker::agent: builder started id="32c9671be459ece7e8f25ecf1e6842a3" pid=11132581worker # [ 174.419355] tribuchet[1096]: 2026-08-30T18:08:55.430809Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="32c9671be459ece7e8f25ecf1e6842a3" pid=1113 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/b5d52cc60b5bb1d2/build2582worker # [ 174.468418] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:55.479836Z INFO tribuchet::worker::agent: builder exited code=02583worker # [ 174.626982] tribuchet[1096]: 2026-08-30T18:08:55.638231Z INFO tribuchet::worker::build::agent_exec: builder finished id="32c9671be459ece7e8f25ecf1e6842a3" exit_code=0 aborted=None2584worker # [ 174.643552] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:55.655002Z INFO tribuchet::worker::agent: cleanup done id="32c9671be459ece7e8f25ecf1e6842a3"2585worker # [ 174.651542] systemd[1]: tribuchet-agent@1.service: Deactivated successfully.2586worker # [ 174.660451] systemd[1]: Started tribuchet-agent@1.service.2587worker # [ 174.686325] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.697496Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362588worker # [ 174.691451] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.702060Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2589worker # [ 174.695687] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.702112Z INFO tribuchet::worker::agent: agent listening uid=9952590worker # [ 174.699748] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.702173Z INFO tribuchet::worker::agent: no build held, exiting until the next activation2591worker # [ 174.705247] systemd[1]: tribuchet-agent@1.service: Deactivated successfully.2592worker # [ 174.734640] tribuchet[1096]: 2026-08-30T18:08:55.745721Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="32c9671be459ece7e8f25ecf1e6842a3"2593worker # [ 174.750372] tribuchet[1096]: 2026-08-30T18:08:55.761820Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="32c9671be459ece7e8f25ecf1e6842a3"2594hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 2.25 seconds)2595hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/667vxncdcca78rn0fyqbrb7rvn7aiyis-tt-tailscale2596hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/667vxncdcca78rn0fyqbrb7rvn7aiyis-tt-tailscale, in 0.04 seconds)2597hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build'2598hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.03 seconds)2599worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished'2600worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.02 seconds)2601(finished: subtest: a build dispatches over the tailnet, in 25.89 seconds)2602subtest: a non-tailnet peer is rejected2603worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml2604worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.01 seconds)2605worker: must succeed: systemctl restart tribuchet-worker2606worker # [ 174.886798] systemd[1]: Stopping tribuchet-worker.service...2607worker # [ 174.890163] tribuchet[1096]: 2026-08-30T18:08:55.897992Z INFO tribuchet::worker: handover requested; exiting2608worker # [ 174.895162] systemd[1]: tribuchet-worker.service: Deactivated successfully.2609worker # [ 174.898502] systemd[1]: Stopped tribuchet-worker.service.2610hub # [ 302.223620] tribuchet[1081]: 2026-08-30T18:08:55.355614Z INFO tribuchet::hub: worker disconnected worker="tt-worker"2611worker # [ 174.900474] systemd[1]: tribuchet-worker.service: Consumed 53ms CPU time over 27.218s wall clock time, 19.2M memory peak, 17.5M read from disk, 4K written to disk, 3.1K incoming IP traffic, 2.1K outgoing IP traffic.2612worker # [ 174.912425] systemd[1]: Starting tribuchet-worker.service...2613worker # [ 174.936783] tribuchet[1144]: 2026-08-30T18:08:55.947984Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet/worker", 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, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: ["/run/tribuchet/agents/1.sock"], spawn_agents: 0, agent_uid_base: None }2614worker # [ 174.949343] tribuchet[1144]: 2026-08-30T18:08:55.960281Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox")2615worker # [ 175.074432] systemd[1]: Started tribuchet-worker.service.2616worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.21 seconds)2617hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed'2618worker # [ 175.087449] systemd[1]: Started tribuchet-agent@1.service.2619worker # [ 175.119666] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1147]: 2026-08-30T18:08:56.130774Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362620worker # [ 175.125359] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1147]: 2026-08-30T18:08:56.136263Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2621worker # [ 175.129930] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1147]: 2026-08-30T18:08:56.136342Z INFO tribuchet::worker::agent: agent listening uid=9952622hub # [ 302.832266] tribuchet[1081]: 2026-08-30T18:08:55.964712Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:328622623worker # [ 175.511594] tribuchet[1144]: 2026-08-30T18:08:56.522950Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2624worker # [ 175.516378] tribuchet[1144]: 2026-08-30T18:08:56.523031Z INFO tribuchet::worker: reconnecting to hub in 1s2625hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.10 seconds)2626(finished: subtest: a non-tailnet peer is rejected, in 1.32 seconds)2627(finished: run the VM test script, in 314.94 seconds)2628hub # [ 304.207610] tribuchet[1081]: 2026-08-30T18:08:57.339175Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:328742629worker # [ 176.881800] tribuchet[1144]: 2026-08-30T18:08:57.892732Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2630worker # [ 176.886730] tribuchet[1144]: 2026-08-30T18:08:57.892810Z INFO tribuchet::worker: reconnecting to hub in 2s2631hub # [ 304.612489] tailscaled[660]: 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": context deadline exceeded2632hub # [ 304.616231] tailscaled[660]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ...2633hub # [ 304.618726] tailscaled[660]: bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 178.62.44.132:443: connect: network is unreachable2634hub # [ 304.623345] tailscaled[660]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ...2635hub # [ 306.576886] tribuchet[1081]: 2026-08-30T18:08:59.708695Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:328902636worker # [ 179.250800] tribuchet[1144]: 2026-08-30T18:09:00.261918Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2637worker # [ 179.254755] tribuchet[1144]: 2026-08-30T18:09:00.261963Z INFO tribuchet::worker: reconnecting to hub in 4s2638hub # [ 307.625108] tailscaled[660]: bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2639hub # [ 307.628853] tailscaled[660]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ...2640hub # [ 307.631266] tailscaled[660]: 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 unreachable2641hub # [ 307.634961] tailscaled[660]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ...2642hub # [ 310.577068] tailscaled[660]: logtail: upload: log upload of 3121 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/78114f96319e3d9a78af39dee54fc29c3cd3d02f94c6efdfb8f98be4e27a636c": context deadline exceeded2643hub # [ 310.587145] tailscaled[660]: health: connectivity impacted; triggering captive portal detection2644hub # [ 310.588793] tailscaled[660]: health(warnable=dns-forward-failing): error: Tailscale can't reach the configured DNS servers. Internet connectivity may be affected.2645hub # [ 310.631091] tailscaled[660]: 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": context deadline exceeded2646hub # [ 310.635064] tailscaled[660]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ...2647hub # [ 310.638082] tailscaled[660]: 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 unreachable2648hub # [ 310.642180] tailscaled[660]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ...2649hub # [ 310.946897] tribuchet[1081]: 2026-08-30T18:09:04.078790Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:571702650worker # [ 183.620763] tribuchet[1144]: 2026-08-30T18:09:04.631916Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2651worker # [ 183.624771] tribuchet[1144]: 2026-08-30T18:09:04.631964Z INFO tribuchet::worker: reconnecting to hub in 8s2652hub # [ 312.591669] tailscaled[660]: health(warnable=dns-forward-failing): ok2653hub # [ 313.639430] tailscaled[660]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": context deadline exceeded2654worker # [ 186.808631] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2655worker # [ 186.813204] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2656hub # [ 317.592100] tailscaled[660]: tailscale.com/feature/captiveportal captiveportal.go:96: subscriber for health.Change is slow (5.000062857s elapsed)2657hub # [ 318.593368] tailscaled[660]: DetectCaptivePortal(found=false)2658worker # [ 191.809437] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2659worker # [ 191.813337] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded2660hub # [ 319.315290] tribuchet[1081]: 2026-08-30T18:09:12.447092Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:571802661worker # [ 191.989228] tribuchet[1144]: 2026-08-30T18:09:13.000214Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2662worker # [ 191.993359] tribuchet[1144]: 2026-08-30T18:09:13.004648Z INFO tribuchet::worker: reconnecting to hub in 16s2663test script finished in 332.16s2664cleanup2665kill QemuMachine (pid 47)2666hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2667kill QemuMachine (pid 48)2668worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2669(finished: cleanup, in 0.45 seconds)