Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: hub, worker, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh start all VMs hub: starting vm worker: starting vm hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.PfsOmI6vm8', fmt=raw size=1073741824 hub # mke2fs 1.47.4 (6-Mar-2025) hub # Discarding device blocks: 0/262144 done hub # Creating filesystem with 262144 4k blocks and 65536 inodes hub # Filesystem UUID: ca613f11-64d2-4e2a-a633-ecf598794f7a hub # Superblock backups stored on blocks: hub # 32768, 98304, 163840, 229376 hub # hub # Allocating group tables: 0/8 done hub # Writing inode tables: 0/8 done hub # Creating journal (8192 blocks): done hub # Writing superblocks and filesystem accounting information: 0/8 done hub # hub # Virtualisation disk image created. hub: QEMU running (pid 47) hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC730+7EF2C730 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC730 7EF2C730 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:08.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 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 2026 hub # [ 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=tty0 hub # [ 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. hub # [ 0.000000] BIOS-provided physical RAM map: hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved hub # [ 0.000000] NX (Execute Disable) protection: active hub # [ 0.000000] APIC: Static calls initialized hub # [ 0.000000] SMBIOS 2.8 present. hub # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 hub # [ 0.000000] DMI: Memory slots populated: 1/1 hub # [ 0.000000] Hypervisor detected: KVM hub # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000001] kvm-clock: using sched offset of 3188485427 cycles hub # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000007] tsc: Detected 3099.998 MHz processor hub # [ 0.001567] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.001601] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.001604] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.004303] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.004324] Using GB pages for direct mapping hub # [ 0.005276] RAMDISK: [mem 0x7e36f000-0x7ffcffff] hub # [ 0.005287] ACPI: Early table checksum verification disabled hub # [ 0.005292] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) hub # [ 0.005297] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005302] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005309] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005312] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.005314] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005317] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005319] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005321] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.005323] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d] hub # [ 0.005325] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219] hub # [ 0.005326] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.005326] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385] hub # [ 0.005327] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd] hub # [ 0.005328] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9] hub # [ 0.005329] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421] hub # [ 0.005980] No NUMA configuration found hub # [ 0.005981] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] hub # [ 0.005985] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] hub # [ 0.006088] Zone ranges: hub # [ 0.006089] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.006091] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] hub # [ 0.006092] Normal empty hub # [ 0.006093] Device empty hub # [ 0.006094] Movable zone start for each node hub # [ 0.006094] Early memory node ranges hub # [ 0.006095] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.006096] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.006097] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] hub # [ 0.006125] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006977] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.051280] On node 0, zone DMA32: 40 pages in unavailable ranges hub # [ 0.052263] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.052278] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.052305] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.052308] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.052310] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.052311] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.052312] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.052313] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.052316] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.052317] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.052323] TSC deadline timer available hub # [ 0.052329] CPU topo: Max. logical packages: 1 hub # [ 0.052329] CPU topo: Max. logical dies: 1 hub # [ 0.052330] CPU topo: Max. dies per package: 1 hub # [ 0.052334] CPU topo: Max. threads per core: 1 hub # [ 0.052336] CPU topo: Num. cores per package: 1 hub # [ 0.052336] CPU topo: Num. threads per package: 1 hub # [ 0.052337] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.052442] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.052480] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.052482] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.052484] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.052485] Booting paravirtualized kernel on KVM hub # [ 0.052489] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.057536] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.060216] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.060273] kvm-guest: PV spinlocks disabled, single CPU hub # [ 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=tty0 hub # [ 0.060405] Unknown kernel command line parameters "regInfo=/nix/store/3aif6jbji958z34g9l8dqvskv1jgr5zm-closure-info/registration", will be passed to user space. hub # [ 0.060426] random: crng init done hub # [ 0.060427] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.062706] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.063867] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.063912] Fallback order for Node 0: 0 hub # [ 0.063917] Built 1 zonelists, mobility grouping on. Total pages: 524150 hub # [ 0.063918] Policy zone: DMA32 hub # [ 0.066647] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.073816] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.078896] allocated 4194304 bytes of page_ext hub # [ 0.088565] ftrace: allocating 48731 entries in 192 pages hub # [ 0.088571] ftrace: allocated 192 pages with 2 groups hub # [ 0.089531] Dynamic Preempt: lazy hub # [ 0.089708] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.089709] rcu: RCU event tracing is enabled. hub # [ 0.089710] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.089711] Trampoline variant of Tasks RCU enabled. hub # [ 0.089711] Rude variant of Tasks RCU enabled. hub # [ 0.089712] Tracing variant of Tasks RCU enabled. hub # [ 0.089713] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.089714] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.089731] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.089733] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.089734] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.095597] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.095942] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.095950] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.096071] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.102753] Console: colour VGA+ 80x25 hub # [ 0.102759] printk: legacy console [tty0] enabled hub # [ 0.145497] printk: legacy console [ttyS0] enabled hub # [ 0.320672] ACPI: Core revision 20250807 hub # [ 0.322394] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.325000] APIC: Switch to symmetric I/O mode setup hub # [ 0.326780] x2apic enabled hub # [ 0.328136] APIC: Switched APIC routing to: physical x2apic hub # [ 0.331203] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.333382] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.336874] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) hub # [ 0.337851] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.337851] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.337851] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.337851] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.337851] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.337851] Spectre V2 : Mitigation: Retpolines hub # [ 0.337851] RETBleed: Mitigation: untrained return thunk hub # [ 0.337851] Speculative Return Stack Overflow: Mitigation: SMT disabled hub # [ 0.337851] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.337864] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT hub # [ 0.338851] Spectre V2 : Enabling Speculation Barrier for firmware calls hub # [ 0.338851] active return thunk: retbleed_return_thunk hub # [ 0.338851] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.338851] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.338851] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.338860] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.340851] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.341851] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. hub # [ 0.354650] Freeing SMP alternatives memory: 44K hub # [ 0.355851] pid_max: default: 32768 minimum: 301 hub # [ 0.356960] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.359057] landlock: Up and running. hub # [ 0.359859] Yama: becoming mindful. hub # [ 0.362363] LSM support for eBPF active hub # [ 0.364096] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.365919] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.370851] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) hub # [ 0.373708] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.374864] ... version: 0 hub # [ 0.376460] ... bit width: 48 hub # [ 0.377856] ... generic counters: 6 hub # [ 0.378856] ... generic bitmap: 000000000000003f hub # [ 0.379856] ... fixed-purpose counters: 0 hub # [ 0.380856] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.381856] ... value mask: 0000ffffffffffff hub # [ 0.382868] ... max period: 00007fffffffffff hub # [ 0.383857] ... global_ctrl mask: 000000000000003f hub # [ 0.385070] signal: max sigframe size: 1776 hub # [ 0.386044] rcu: Hierarchical SRCU implementation. hub # [ 0.386861] rcu: Max phase no-delay instances is 400. hub # [ 0.394219] smp: Bringing up secondary CPUs ... hub # [ 0.395439] smp: Brought up 1 node, 1 CPU hub # [ 0.396879] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) hub # [ 0.398316] Memory: 1971636K/2096600K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115488K reserved, 0K cma-reserved) hub # [ 0.400491] devtmpfs: initialized hub # [ 0.401942] x86/mm: Memory block size: 128MB hub # [ 0.404796] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.406030] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.407041] pinctrl core: initialized pinctrl subsystem hub # [ 0.408753] PM: RTC time: 18:03:52, date: 2026-08-30 hub # [ 0.415861] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.417988] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.419924] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.421267] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.421891] audit: initializing netlink subsys (disabled) hub # [ 0.423503] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.423505] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.424866] audit: type=2000 audit(1788113032.702:1): state=initialized audit_enabled=0 res=1 hub # [ 0.426879] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.426882] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.427861] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.428942] cpuidle: using governor menu hub # [ 0.432627] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.434691] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.435865] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.436890] PCI: Using configuration type 1 for base access hub # [ 0.438311] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.449993] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.450862] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.453877] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.454856] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.471099] ACPI: Added _OSI(Module Device) hub # [ 0.471860] ACPI: Added _OSI(Processor Device) hub # [ 0.477865] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.491384] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.496498] ACPI: Interpreter enabled hub # [ 0.496952] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.498876] ACPI: Using IOAPIC for interrupt routing hub # [ 0.500056] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.509864] PCI: Using E820 reservations for host bridge windows hub # [ 0.511084] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.527889] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.528875] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.529978] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.530991] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.532588] PCI host bridge to bus 0000:00 hub # [ 0.533838] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.534858] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.535858] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.536858] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.537860] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.538862] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] hub # [ 0.539861] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.541116] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.543066] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.545953] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.546882] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.547915] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.549181] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.552400] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.556878] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.557871] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.558958] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.560942] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.566055] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.569915] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.570898] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.571963] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.574156] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.576922] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.578882] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.579924] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.582739] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.586890] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.588879] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.591043] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.593595] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.596878] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.597883] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.599054] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.601962] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.606897] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.607915] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.608961] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.614753] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.618890] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.619879] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.620907] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.622873] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.625872] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.630898] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.632917] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.635077] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.637885] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.639882] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.640923] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.645107] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.648882] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] hub # [ 0.649873] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.650910] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.654240] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.657879] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] hub # [ 0.659458] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.663473] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] hub # [ 0.664443] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.667917] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] hub # [ 0.669856] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.672870] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.676142] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.678925] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.681748] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.685031] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] hub # [ 0.685869] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.689054] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.691916] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.702893] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.703984] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.704983] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.706105] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.707986] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.708992] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.709994] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.711535] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.712920] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.713873] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.714873] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.716119] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.716873] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.718869] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.719879] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.721869] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.725253] iommu: Default domain type: Translated hub # [ 0.725864] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.727191] ACPI: bus type USB registered hub # [ 0.727924] usbcore: registered new interface driver usbfs hub # [ 0.728874] usbcore: registered new interface driver hub hub # [ 0.729875] usbcore: registered new device driver usb hub # [ 0.732293] NetLabel: Initializing hub # [ 0.732856] NetLabel: domain hash size = 128 hub # [ 0.734855] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.735903] NetLabel: unlabeled traffic allowed by default hub # [ 0.736870] PCI: Using ACPI for IRQ routing hub # [ 0.858203] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 0.858851] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 0.858851] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.858856] vgaarb: loaded hub # [ 0.859751] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.860728] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.865964] clocksource: Switched to clocksource kvm-clock hub # [ 0.870255] VFS: Disk quotas dquot_6.6.0 hub # [ 0.871349] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.873470] pnp: PnP ACPI init hub # [ 0.874758] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 0.876208] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 0.878566] pnp: PnP ACPI: found 6 devices hub # [ 0.886533] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.888765] clocksource: Switched to clocksource acpi_pm hub # [ 0.890308] NET: Registered PF_INET protocol family hub # [ 0.892133] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.912661] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.915258] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.917286] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.919585] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.922146] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.923942] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.926235] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.927965] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.929959] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.931442] NET: Registered PF_XDP protocol family hub # [ 0.932739] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.934291] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.935960] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.937759] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 0.939516] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 0.941546] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] hub # [ 0.943884] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 0.946323] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 0.948621] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 0.950787] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 0.953032] PCI: CLS 0 bytes, default 64 hub # [ 0.954297] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.956842] Trying to unpack rootfs image as initramfs... hub # [ 1.004671] Initialise system trusted keyrings hub # [ 1.008120] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 1.035857] Key type asymmetric registered hub # [ 1.038950] Asymmetric key parser 'x509' registered hub # [ 1.040304] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 1.047114] io scheduler mq-deadline registered hub # [ 1.048310] io scheduler kyber registered hub # [ 1.052582] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 1.058302] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 1.064500] Linux agpgart interface v0.103 hub # [ 1.065776] ACPI: bus type drm_connector registered hub # [ 1.069390] usbcore: registered new interface driver usbserial_generic hub # [ 1.071009] usbserial: USB Serial support registered for generic hub # [ 1.074945] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 1.077096] drop_monitor: Initializing network drop monitor service hub # [ 1.084107] NET: Registered PF_INET6 protocol family hub # [ 1.088407] Segment Routing with IPv6 hub # [ 1.089491] In-situ OAM (IOAM) with IPv6 hub # [ 1.093394] IPI shorthand broadcast: enabled hub # [ 1.101344] sched_clock: Marking stable (862028854, 238902408)->(2289558128, -1188626866) hub # [ 1.109089] registered taskstats version 1 hub # [ 1.110628] Loading compiled-in X.509 certificates hub # [ 1.124123] Demotion targets for Node 0: null hub # [ 1.128004] Key type .fscrypt registered hub # [ 1.129093] Key type fscrypt-provisioning registered hub # [ 1.133081] ima: No TPM chip found, activating TPM-bypass! hub # [ 1.134592] ima: Allocated hash algorithm: sha1 hub # [ 1.139065] ima: No architecture policies found hub # [ 1.140446] PM: Magic number: 6:690:90 hub # [ 1.144658] RAS: Correctable Errors collector initialized. hub # [ 1.158969] clk: Disabling unused clocks hub # [ 1.160086] PM: genpd: Disabling unused power domains hub # [ 1.439106] Freeing initrd memory: 29060K hub # [ 1.445388] Freeing unused decrypted memory: 2028K hub # [ 1.448633] Freeing unused kernel image (initmem) memory: 3644K hub # [ 1.453447] Write protecting the kernel read-only data: 32768k hub # [ 1.455970] Freeing unused kernel image (text/rodata gap) memory: 1216K hub # [ 1.460283] Freeing unused kernel image (rodata/data gap) memory: 756K hub # [ 1.523044] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.524780] Run /init as init process hub # [ 1.536848] systemd[1]: Inserted module 'autofs4' hub # [ 1.556192] fuse: init (API version 7.45) hub # [ 1.563712] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.567321] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.571986] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.575476] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 1.635072] systemd[1]: Successfully made /usr/ read-only. hub # [ 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) hub # [ 1.987477] systemd[1]: Detected virtualization kvm. hub # [ 1.990459] systemd[1]: Detected architecture x86-64. hub # [ 1.993613] systemd[1]: Running in initrd. hub # [ 1.998332] systemd[1]: Initializing machine ID from random generator. hub # [ 2.001786] systemd[1]: Hostname set to . hub # [ 2.331977] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 2.462625] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 2.478305] systemd[1]: Created slice Slice /system/modprobe. hub # [ 2.488045] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 2.498057] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 2.502562] systemd[1]: Reached target Path Units. hub # [ 2.509557] systemd[1]: Reached target Slice Units. hub # [ 2.512364] systemd[1]: Reached target Swaps. hub # [ 2.521107] systemd[1]: Reached target Timer Units. hub # [ 2.523536] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 2.551468] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 2.615195] systemd[1]: Listening on Journal Sockets. hub # [ 2.618551] systemd[1]: Listening on udev Control Socket. hub # [ 2.624552] systemd[1]: Listening on udev Kernel Socket. hub # [ 2.626682] systemd[1]: Reached target Socket Units. hub # [ 2.713324] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 2.728570] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.754713] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.793307] systemd[1]: Starting Journal Service... hub # [ 2.811703] systemd[1]: Starting Load Kernel Modules... hub # [ 2.823085] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.826739] netfs: FS-Cache loaded hub # [ 2.835776] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.850496] 9pnet: Installing 9P2000 support hub # [ 2.863997] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.892831] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.906107] systemd-journald[68]: Collecting audit messages is disabled. hub # [ 2.913874] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.930937] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.942071] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.946535] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.954987] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.963805] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.988392] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 3.009068] systemd[1]: Finished Load Kernel Modules. hub # [ 3.018154] systemd[1]: Starting Apply Kernel Variables... hub # [ 3.043150] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 3.056431] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 3.080120] systemd[1]: Finished Apply Kernel Variables. hub # [ 3.104123] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.868591] systemd-modules-load[69]: Inserted module 'dm_mod' hub # [ 2.871852] systemd-modules-load[69]: Inserted module 'virtio_balloon'[ 3.112343] systemd[1]: Started Journal Service. hub # hub # [ 2.874994] systemd-modules-load[69]: Inserted module 'virtio_gpu' hub # [ 2.889192] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.892757] systemd[1]: Reached target Local File Systems. hub # [ 2.897055] systemd[1]: Starting Create System Files and Directories... hub # [ 2.904782] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.941089] systemd[1]: Finished Create System Files and Directories. hub # [ 2.965692] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.970564] systemd-udevd[83]: Using default interface naming scheme 'v261'. hub # [ 2.990831] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.994331] systemd[1]: Reached target System Initialization. hub # [ 2.995667] systemd[1]: Reached target Basic System. hub # [ 3.564051] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 3.595653] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 3.605583] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 3.618748] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 3.631129] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 3.632446] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 3.634779] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 hub # [ 3.644313] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 3.645558] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 3.647256] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 3.649010] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.654972] usb usb1: Product: EHCI Host Controller hub # [ 3.656268] usb usb1: Manufacturer: Linux 6.18.46 ehci_hcd hub # [ 3.658729] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 3.661362] hub 1-0:1.0: USB hub found hub # [ 3.663514] hub 1-0:1.0: 6 ports detected hub # [ 3.683147] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 3.684502] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 3.712958] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 3.729406] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 hub # [ 3.746581] SCSI subsystem initialized hub # [ 3.765863] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.813970] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 3.600927] systemd[1]: Starting Virtual Console Setup... hub # [ 3.852670] usb usb2: Product: UHCI Host Controller hub # [ 3.865040] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 3.635427] (udev-worker)[88]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 3.652304] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.899016] usb usb2: Manufacturer: Linux 6.18.46 uhci_hcd hub # [ 3.665418] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line. hub # [ 3.907068] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 3.682395] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 3.691102] systemd[1]: Finished Virtual Console Setup. hub # [ 3.933100] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 3.963191] hub 2-0:1.0: USB hub found hub # [ 3.986086] hub 2-0:1.0: 2 ports detected hub # [ 4.008290] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 4.009590] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 4.028451] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 3.791907] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 3.793671] systemd[1]: Reached target Initrd Root Device. hub # [ 4.033778] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 hub # [ 3.798391] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 4.042978] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 4.044634] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 4.055939] usb usb3: Product: UHCI Host Controller hub # [ 4.064686] usb usb3: Manufacturer: Linux 6.18.46 uhci_hcd hub # [ 4.066475] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 4.068070] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 4.072338] usb 1-1: Product: QEMU USB Tablet hub # [ 4.073597] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 4.074744] usb 1-1: Manufacturer: QEMU hub # [ 4.075715] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 4.078635] hub 3-0:1.0: USB hub found hub # [ 4.081159] hub 3-0:1.0: 2 ports detected hub # [ 4.093079] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 4.096312] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 4.101548] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 4.105778] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 hub # [ 4.110833] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 4.113107] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 3.881154] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 4.121718] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 4.124604] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 4.128901] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 4.130336] usb usb4: Product: UHCI Host Controller hub # [ 4.132960] usb usb4: Manufacturer: Linux 6.18.46 uhci_hcd hub # [ 4.135220] hid: raw HID events driver (C) Jiri Kosina hub # [ 4.136696] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 4.141285] scsi host0: ahci hub # [ 4.142171] hub 4-0:1.0: USB hub found hub # [ 4.143844] scsi host1: ahci hub # [ 4.146979] scsi host2: ahci hub # [ 4.148687] hub 4-0:1.0: 2 ports detected hub # [ 3.913503] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 4.160352] scsi host3: ahci hub # [ 4.163549] scsi host4: ahci hub # [ 4.165670] scsi host5: ahci hub # [ 4.166827] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 hub # [ 4.172057] usbcore: registered new interface driver usbhid hub # [ 4.179733] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 hub # [ 4.181661] usbhid: USB HID core driver hub # [ 4.190058] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 hub # [ 4.200928] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 hub # [ 4.202578] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 hub # [ 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/input2 hub # [ 4.249798] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 hub # [ 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/input0 hub # [ 4.568218] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 4.569703] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 4.571827] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 4.573786] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 4.577989] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 4.580913] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 4.582244] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 4.586225] ata3.00: applying bridge limits hub # [ 4.590485] ata3.00: configured for UDMA/100 hub # [ 4.592621] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 4.770002] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 4.783847] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 4.736977] systemd[1]: Mounting /sysroot... hub # [ 5.287102] EXT4-fs (vda): mounted filesystem ca613f11-64d2-4e2a-a633-ecf598794f7a r/w with ordered data mode. Quota mode: none. hub # [ 5.060092] systemd[1]: Mounted /sysroot. hub # [ 5.062137] systemd[1]: Reached target Initrd Root File System. hub # [ 5.068217] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 5.071874] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 5.087767] systemd[1]: Mounting /sysroot/run... hub # [ 5.107302] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 5.127226] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 5.159769] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 5.627743] 9p: Installing v9fs 9p2000 file system support hub # [ 5.417310] systemd-sysroot-fstab-check[153]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 5.430845] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 5.438135] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 5.440747] systemd[1]: Mounted /sysroot/run. hub # [ 5.445993] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 5.495983] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 5.519166] systemd[1]: Reload requested from client PID 153 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 5.529128] systemd[1]: Reloading... hub # [ 5.863418] systemd[1]: Reloading finished in 330 ms. hub # [ 5.889112] systemd-sysroot-fstab-check[153]: Requesting initrd-fs.target/start/replace... hub # [ 5.901433] systemd-sysroot-fstab-check[153]: Requesting swap.target/start/replace... hub # [ 5.918092] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 6.019729] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 6.047172] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 6.050065] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 6.073235] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 6.076638] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 6.079935] systemd[1]: Mounting /sysroot/nix/store... hub # [ 6.112113] systemd[1]: Mounted /sysroot/nix/store. hub # [ 6.113452] systemd[1]: Reached target Initrd File Systems. hub # [ 6.120089] systemd[1]: Starting Find NixOS closure... hub # [ 6.126796] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 6.161874] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 6.166042] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 6.180332] systemd[1]: Finished Find NixOS closure. hub # [ 6.182885] systemd[1]: Reached target Initrd Default Target. hub # [ 6.190525] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 6.213745] systemd[1]: Stopped target Initrd Default Target. hub # [ 6.218187] systemd[1]: Stopped target Basic System. hub # [ 6.219479] systemd[1]: Stopped target Initrd Root Device. hub # [ 6.220938] systemd[1]: Stopped target Path Units. hub # [ 6.222889] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 6.224430] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 6.226848] systemd[1]: Stopped target Slice Units. hub # [ 6.227970] systemd[1]: Stopped target Socket Units. hub # [ 6.230365] systemd[1]: Stopped target System Initialization. hub # [ 6.233098] systemd[1]: Stopped target Swaps. hub # [ 6.234194] systemd[1]: Stopped target Timer Units. hub # [ 6.235341] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 6.237831] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 6.240311] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 6.242161] systemd[1]: Stopped Find NixOS closure. hub # [ 6.243846] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 6.248115] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 6.251241] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 6.252798] systemd[1]: Stopped Apply Kernel Variables. hub # [ 6.254892] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 6.257516] systemd[1]: Stopped Load Kernel Modules. hub # [ 6.258745] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 6.262225] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 6.264764] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 6.266750] systemd[1]: Stopped Create System Files and Directories. hub # [ 6.270203] systemd[1]: Stopped target Local File Systems. hub # [ 6.272670] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 6.274246] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 6.276440] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 6.280491] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 6.283102] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 6.285319] systemd[1]: Stopped Virtual Console Setup. hub # [ 6.295089] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 6.299199] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 6.303350] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 6.305657] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 6.310410] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 6.314097] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 6.318101] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 6.320304] systemd[1]: Closed udev Control Socket. hub # [ 6.323161] systemd[1]: Starting Cleanup udev Database... hub # [ 6.325266] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 6.328228] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 6.329803] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 6.331997] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 6.333538] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 6.335270] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 6.351797] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 6.356259] systemd[1]: Finished Cleanup udev Database. hub # [ 6.358100] systemd[1]: Reached target Switch Root. hub # [ 6.359989] systemd[1]: Starting NixOS Activation... hub # [ 7.215986] initrd-nixos-activation-start[198]: booting system configuration /nix/store/nbr9125msn90csg49rxlfs8fiwxq69y2-nixos-system-hub-test hub # [ 7.309575] initrd-nixos-activation-start[198]: running activation script... hub # [ 11.801526] initrd-nixos-activation-start[221]: setting up /etc... hub # [ 13.076597] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 13.080191] systemd[1]: Finished NixOS Activation. hub # [ 13.084275] systemd[1]: Starting Switch Root... hub # [ 13.121904] systemd[1]: Switching root. hub # [ 13.556913] systemd-journald[68]: Received SIGTERM from PID 1 (systemd). hub # [ 30.544365] NET: Registered PF_VSOCK protocol family hub # [ 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) hub # [ 30.960097] systemd[1]: Detected virtualization kvm. hub # [ 30.961352] systemd[1]: Detected architecture x86-64. hub # [ 30.964868] systemd[1]: Detected first boot. hub # [ 30.970377] systemd[1]: Initializing machine ID from random generator. hub # [ 39.203076] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 39.827411] systemd[1]: Applying preset policy. hub # [ 42.591541] systemd[1]: Populated /etc with preset unit settings. hub # [ 44.110918] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 44.113173] systemd[1]: Stopped initrd-switch-root.service. hub # [ 44.123010] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 44.128823] systemd[1]: Created slice Slice /system/getty. hub # [ 44.131205] systemd[1]: Created slice User and Session Slice. hub # [ 44.132630] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 44.134535] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 44.136167] systemd[1]: Expecting device /dev/hvc0... hub # [ 44.137342] systemd[1]: Expecting device /dev/ttyS0... hub # [ 44.138606] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 44.139960] systemd[1]: Stopped target initrd-fs.target. hub # [ 44.141198] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 44.142572] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 44.144053] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 44.145599] systemd[1]: Reached target Path Units. hub # [ 44.146828] systemd[1]: Reached target Remote File Systems. hub # [ 44.148181] systemd[1]: Reached target Slice Units. hub # [ 44.149484] systemd[1]: Reached target Swaps. hub # [ 44.157850] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 44.169129] systemd[1]: Listening on Process Core Dump Socket. hub # [ 44.176093] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 44.181333] systemd[1]: Listening on Factory Reset Management. hub # [ 44.182842] systemd[1]: Listening on Hostname Service Socket. hub # [ 44.189023] systemd[1]: Starting Journal Log Access Socket... hub # [ 44.197050] systemd[1]: Listening on Journal Audit Socket. hub # [ 44.201699] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 44.203465] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 44.206008] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 44.207969] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 44.232321] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 44.233872] systemd[1]: Listening on udev Control Socket. hub # [ 44.235466] systemd[1]: Listening on udev Varlink Socket. hub # [ 44.244935] systemd[1]: Mounting Huge Pages File System... hub # [ 44.249784] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 44.254551] systemd[1]: Mounting Kernel Debug File System... hub # [ 44.270538] systemd[1]: Mounting Kernel Trace File System... hub # [ 44.291644] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 44.296347] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 44.311611] systemd[1]: Starting Load Kernel Module configfs... hub # [ 44.313590] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 44.317957] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 44.323094] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 44.335255] systemd[1]: Mounting FUSE Control File System... hub # [ 44.348083] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 44.409186] systemd[1]: Starting Journal Service... hub # [ 44.431549] systemd[1]: Starting Load Kernel Modules... hub # [ 44.623997] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... hub # [ 44.648774] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 44.659567] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 44.679565] systemd[1]: Starting Coldplug All udev Devices... hub # [ 44.683459] systemd[1]: Listening on Journal Log Access Socket. hub # [ 44.696607] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 44.729247] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 44.806562] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 44.815623] systemd[1]: Finished Load Kernel Module configfs. hub # [ 44.822703] systemd[1]: Mounted Huge Pages File System. hub # [ 44.828532] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 44.842706] systemd[1]: Mounted Kernel Debug File System. hub # [ 44.848735] systemd[1]: Mounted Kernel Trace File System. hub # [ 44.874004] systemd[1]: Mounted FUSE Control File System. hub # [ 45.046909] systemd-journald[291]: Collecting audit messages is enabled. hub # [ 45.084741] systemd[1]: Mounting Kernel Configuration File System... hub # [ 45.135811] EXT4-fs (vda): re-mounted ca613f11-64d2-4e2a-a633-ecf598794f7a. hub # [ 45.394591] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 45.417062] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 45.424662] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 45.200062] systemd[1]: Queued start job for default target Multi-User System. hub # [ 45.202667] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 45.453807] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 45.457003] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 45.461981] systemd[1]: Started Journal Service. hub # [ 45.490867] loop: module loaded hub # [ 45.283301] systemd-modules-load[292]: Inserted module 'loop' hub # [ 45.404096] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 45.497994] systemd[1]: Finished Coldplug All udev Devices. hub # [ 45.727670] systemd-oomd[293]: No swap; memory pressure usage will be degraded hub # [ 45.840491] systemd-modules-load[292]: Inserted module 'tls' hub # [ 45.869678] systemd[1]: Finished Load Kernel Modules. hub # [ 45.879838] systemd[1]: Starting Firewall... hub # [ 45.895141] systemd[1]: Starting Apply Kernel Variables... hub # [ 45.899696] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 46.175772] systemd-journald[291]: Received client request to flush runtime journal. hub # [ 46.079482] systemd[1]: Mounted Kernel Configuration File System. hub # [ 46.081216] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 46.082392] systemd[1]: Reached target First Boot Complete. hub # [ 46.083602] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 46.086228] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 46.100100] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 46.150489] systemd[1]: Finished Apply Kernel Variables. hub # [ 46.299080] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 46.305406] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 46.319528] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 46.863825] systemd-udevd[328]: Using default interface naming scheme 'v261'. hub # [ 46.943666] systemd[1]: Mounting /run/wrappers... hub # [ 47.209380] systemd[1]: Mounted /run/wrappers. hub # [ 47.211289] systemd[1]: Reached target Local File Systems. hub # [ 47.219958] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 47.224892] systemd[1]: Starting register-nix-paths.service... hub # [ 47.232337] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 47.234094] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 47.247252] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 47.293685] systemd[1]: Starting Create System Files and Directories... hub # [ 47.473418] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 47.512637] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 47.645394] systemd[1]: Finished Create System Files and Directories. hub # [ 47.653126] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 47.660830] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 47.735298] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 47.874092] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 47.951967] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 48.030958] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 48.042698] systemd[1]: Starting Update is Completed... hub # [ 48.580847] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. hub # [ 48.590085] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 48.829721] systemd[1]: Finished Update is Completed. hub # [ 48.922782] (udev-worker)[383]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 48.934349] (udev-worker)[383]: Network interface NamePolicy= disabled on kernel command line. hub # [ 48.938807] (udev-worker)[377]: Network interface NamePolicy= disabled on kernel command line. hub # [ 49.277794] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 49.309280] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console hub # [ 49.343454] mousedev: PS/2 mouse device common for all mice hub # [ 49.351491] ACPI: button: Power Button [PWRF] hub # [ 49.357947] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 hub # [ 49.404211] Console: switching to colour dummy device 80x25 hub # [ 49.430558] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 49.431561] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 49.465631] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic hub # [ 49.475504] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 hub # [ 49.297706] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 49.304677] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 49.311539] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 49.313449] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 49.317948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 49.322562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 49.325243] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 49.569137] rtc_cmos 00:04: RTC can wake from S4 hub # [ 49.598971] rtc_cmos 00:04: registered as rtc0 hub # [ 49.605717] rtc_cmos 00:04: setting system clock to 2026-08-30T18:04:42 UTC (1788113082) hub # [ 49.612165] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized hub # [ 49.626778] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 49.629659] parport_pc 00:02: reported by Plug and Play ACPI hub # [ 49.672335] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 49.941799] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt hub # [ 49.941948] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD hub # [ 49.955848] Console: switching to colour frame buffer device 160x50 hub # [ 49.965312] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 49.965868] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 49.972051] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device hub # [ 49.761122] systemd[1]: Starting Virtual Console Setup... hub # [ 50.246694] kvm_amd: TSC scaling supported hub # [ 50.247289] kvm_amd: Nested Virtualization enabled hub # [ 50.248471] kvm_amd: Nested Paging enabled hub # [ 50.249042] kvm_amd: LBR virtualization supported hub # [ 50.249972] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 50.252567] kvm_amd: Virtual GIF supported hub # [ 50.332104] EDAC MC: Ver: 3.0.0 hub # [ 50.245118] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 50.249190] systemd[1]: Stopped Virtual Console Setup. hub # [ 50.270435] systemd[1]: Starting Virtual Console Setup... hub # [ 50.314679] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 50.318459] systemd[1]: Stopped Virtual Console Setup. hub # [ 50.335473] systemd[1]: Starting Virtual Console Setup... hub # [ 50.578319] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # [ 50.585600] ppdev: user-space parallel port driver hub # [ 50.631416] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) hub # [ 50.413308] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 50.416340] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 51.179810] systemd[1]: Finished register-nix-paths.service. hub # [ 51.457355] systemd-vconsole-setup[496]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 51.463746] systemd[1]: Finished Virtual Console Setup. hub # [ 51.466879] systemd[1]: Reached target System Initialization. hub # [ 51.469422] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 51.471754] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 51.474136] systemd[1]: Reached target Timer Units. hub # [ 51.475950] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 51.477920] systemd[1]: Listening on Nix Daemon Socket. hub # [ 51.480395] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 51.483206] systemd[1]: Reached target Socket Units. hub # [ 51.484553] systemd[1]: Reached target Basic System. hub # [ 51.487328] systemd[1]: Started backdoor.service. hub # [ 51.492931] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 51.502650] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 51.515446] systemd[1]: Starting Post-Boot Actions... hub # [ 51.530712] systemd[1]: Started Reset console on configuration changes. hub # [ 51.548918] systemd[1]: Starting resolvconf update... hub # [ 51.581113] systemd[1]: Finished Firewall. hub # [ 51.631855] systemd[1]: Starting D-Bus System Message Bus... hub # connecting to host... hub # [ 51.674456] systemd[1]: Finished Post-Boot Actions. hub # [ 51.700335] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 51.703955] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 51.706535] systemd[1]: Reached target User and Group Name Lookups. hub # [ 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" hub # [ 51.726167] systemd[1]: Starting User Login Management... hub # [ 51.733318] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 51.854678] systemd-logind[583]: New seat seat0. hub # [ 51.860645] systemd-logind[583]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 51.863508] systemd-logind[583]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) hub # [ 51.869171] systemd-logind[583]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) hub # [ 51.871233] systemd[1]: Started User Login Management. hub # [ 51.881137] systemd[1]: Starting linger-users.service... hub # [ 51.883572] dbus-broker-launch[567]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 51.919712] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 51.923158] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 51.925883] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 51.928884] dbus-broker-launch[567]: NSS returned no entry for 'systemd-timesync' hub # [ 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" hub # [ 51.937281] systemd[1]: Stopping User and Group Name Lookups... hub # [ 51.939275] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 51.942767] systemd[1]: nscd.service: Deactivated successfully. hub # [ 51.946145] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 51.965407] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 51.995495] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 51.997992] systemd[1]: Finished linger-users.service. hub # [ 52.003527] systemd[1]: Started D-Bus System Message Bus. hub # [ 52.043766] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 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" hub # [ 52.050763] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 52.053486] systemd[1]: Reached target User and Group Name Lookups. hub # [ 52.059535] dbus-broker-launch[567]: Ready hub # [ 52.089327] systemd[1]: Finished resolvconf update. hub # [ 52.092111] systemd[1]: Reached target Preparation for Network. hub # [ 52.098245] systemd[1]: Starting DHCP Client... hub # [ 52.101887] systemd[1]: Starting Address configuration of eth1... hub # [ 52.107175] systemd[1]: Starting Extra networking commands.... hub # [ 52.123709] systemd[1]: Starting Tailscale node agent... hub # [ 52.288642] network-addresses-eth1-start[658]: adding address 192.168.1.1/24... done hub # [ 52.317133] network-addresses-eth1-start[658]: adding address 2001:db8:1::1/64... done hub # [ 52.348721] systemd[1]: Finished Address configuration of eth1. hub # [ 52.390757] dhcpcd[669]: dhcpcd-10.3.2 starting hub # [ 52.411770] dhcpcd[723]: dev: loaded udev hub # [ 52.468462] systemd[1]: Finished Extra networking commands.. hub # [ 52.473094] systemd[1]: Reached target Network. hub # [ 52.479526] systemd[1]: Starting Nginx Web Server... hub # [ 52.485654] systemd[1]: Starting Permit User Sessions... hub # [ 52.740475] 8021q: 802.1Q VLAN Support v1.8 hub # [ 52.741282] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 52.611144] systemd[1]: Finished Permit User Sessions. hub # [ 52.625457] systemd[1]: Started Getty on tty1. hub # [ 52.630790] systemd[1]: Reached target Login Prompts. hub # [ 52.671904] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. hub # [ 53.013857] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 53.121216] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 53.122721] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 53.133874] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 53.139840] cfg80211: failed to load regulatory.db hub # [ 53.366592] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 53.131745] dhcpcd[723]: eth0: waiting for carrier hub # [ 53.264551] dhcpcd[723]: eth0: carrier acquired hub # [ 53.305881] dhcpcd[723]: DUID 00:01:00:01:32:27:2d:3e:52:54:00:12:34:56 hub # [ 53.307861] dhcpcd[723]: eth0: IAID 00:12:34:56 hub # [ 53.309216] dhcpcd[723]: eth0: adding address fe80::5054:ff:fe12:3456 hub # [ 53.338575] tailscaled[660]: TPM: error opening: stat /dev/tpmrm0: no such file or directory hub # [ 53.352589] nginx-pre-start[740]: nginx: the configuration file /nix/store/k1bflm5srhmlm6ngn48yw7qdvzbhgndn-nginx.conf syntax is ok hub # [ 53.356062] nginx-pre-start[740]: nginx: configuration file /nix/store/k1bflm5srhmlm6ngn48yw7qdvzbhgndn-nginx.conf test is successful hub # [ 53.368095] systemd[1]: Started Nginx Web Server. hub # [ 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"} hub # [ 53.420828] tailscaled[660]: LogID: ffc315636e6a75cc80db01f889b2957b18459eb86077209d1b728a42152a19e9 hub # [ 53.422873] tailscaled[660]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 53.424565] tailscaled[660]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 53.427469] tailscaled[660]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil hub # [ 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. hub # [ 53.493690] tailscaled[660]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 53.497124] tailscaled[660]: dns: using "openresolv" mode hub # [ 53.505291] tailscaled[660]: dns: using dns.openresolvManager hub # [ 53.925424] tailscaled[660]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found hub # [ 53.937539] systemd[1]: Started Tailscale node agent. hub # [ 53.943159] tailscaled[660]: wgengine.NewUserspaceEngine(tun "tailscale0") ... hub # [ 54.214740] tun: Universal TUN/TAP device driver, 1.6 hub # [ 53.987815] (udev-worker)[751]: Network interface NamePolicy= disabled on kernel command line. hub # [ 54.060681] tailscaled[660]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 54.063129] tailscaled[660]: dns: using "openresolv" mode hub # [ 54.078411] tailscaled[660]: dns: using dns.openresolvManager hub # [ 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} hub # [ 54.092891] tailscaled[660]: magicsock: disco key = d:2e9d1052a7d56760 hub # [ 54.094826] tailscaled[660]: Creating WireGuard device... hub # [ 54.100765] tailscaled[660]: router: portUpdate(port=41641, network=udp6) hub # [ 54.103102] tailscaled[660]: router: using firewall mode pref hub # [ 54.118968] tailscaled[660]: Bringing WireGuard device up... hub # [ 54.122860] tailscaled[660]: Bringing router up... hub # [ 54.132266] tailscaled[660]: external route: up hub # [ 54.164579] tailscaled[660]: router: default choosing iptables hub # [ 54.218457] tailscaled[660]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 54.221227] tailscaled[660]: router: portUpdate(port=41641, network=udp4) hub # [ 54.227321] tailscaled[660]: Clearing router settings... hub # [ 54.229834] tailscaled[660]: Starting network monitor... hub # [ 54.233535] tailscaled[660]: Engine created. hub # [ 54.282378] tailscaled[660]: pm: migrating "_daemon" profile to new format hub # [ 54.285715] tailscaled[660]: envknob: PORT="41641" hub # [ 54.296680] tailscaled[660]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 54.299604] tailscaled[660]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 54.307256] tailscaled[660]: got LocalBackend in 367ms hub # [ 54.308978] tailscaled[660]: Start hub # [ 54.311127] tailscaled[660]: ipnext: "conn25": skipping extension hub # [ 54.313866] tailscaled[660]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop hub # [ 54.329706] tailscaled[660]: profile data directory: profile not found hub # [ 54.334237] tailscaled[660]: Backend: logs: be:ffc315636e6a75cc80db01f889b2957b18459eb86077209d1b728a42152a19e9 fe: hub # [ 54.337557] tailscaled[660]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 54.339889] tailscaled[660]: blockEngineUpdates(true) hub # [ 54.342214] tailscaled[660]: wgengine: Reconfig: configuring router hub # [ 54.343869] tailscaled[660]: wgengine: Reconfig: user dialer hub # [ 54.345201] tailscaled[660]: wgengine: Reconfig: configuring DNS hub # [ 54.347115] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 54.349113] tailscaled[660]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 54.351136] tailscaled[660]: dns: OScfg: {} hub # [ 54.366898] tailscaled[660]: health(warnable=wantrunning-false): error: Tailscale is stopped. hub # [ 55.072227] dhcpcd[723]: eth0: soliciting an IPv6 router hub # [ 55.075341] dhcpcd[723]: eth0: Router Advertisement from fe80::2 hub # [ 55.076774] dhcpcd[723]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 55.078615] dhcpcd[723]: eth0: adding route to fec0::/64 hub # [ 55.079944] dhcpcd[723]: eth0: adding default route via fe80::2 hub # [ 55.097211] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 55.099457] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 55.125576] dhcpcd[723]: eth0: soliciting a DHCP lease hub # [ 55.420587] NET: Registered PF_PACKET protocol family hub # [ 55.216556] dhcpcd[723]: eth0: offered 10.0.2.15 from 10.0.2.2 hub # [ 55.226245] dhcpcd[723]: eth0: probing address 10.0.2.15/24 hub # [ 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] hub # [ 55.327357] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 55.329519] tailscaled[660]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 55.334618] tailscaled[660]: dns: OScfg: {} hub # [ 55.499760] tailscaled[660]: wgengine: set DNS config again after major link change hub # [ 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] hub # [ 55.514064] tailscaled[660]: magicsock: 0 active derp conns hub # [ 55.524078] tailscaled[660]: router: portUpdate(port=41641, network=udp6) hub # [ 55.527949] tailscaled[660]: router: portUpdate(port=41641, network=udp4) hub # [ 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... hub # [ 55.568791] tailscaled[660]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 55.580207] tailscaled[660]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ... hub # [ 56.130214] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=fec0::1e5:f170:95c9:828d/128, gw=, outif=2, table=255 hub # [ 56.514164] tailscaled[660]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub # [ 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 exceeded hub # [ 58.587346] tailscaled[660]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 58.594582] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ... hub # [ 60.007206] dhcpcd[723]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 60.011374] dhcpcd[723]: eth0: adding route to 10.0.2.0/24 hub # [ 60.015741] dhcpcd[723]: eth0: adding default route via 10.0.2.2 hub # [ 60.018895] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 60.025444] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 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] hub # [ 60.087121] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 60.089317] tailscaled[660]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 60.091286] tailscaled[660]: dns: OScfg: {} hub # [ 60.092280] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 60.094330] tailscaled[660]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 60.456967] systemd[1]: Started DHCP Client. hub # [ 60.461402] systemd[1]: Reached target Network is Online. hub # [ 60.475234] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 60.478242] systemd[1]: Reached target Multi-User System. hub # [ 60.479905] systemd[1]: Startup finished in 1.290s (kernel) + 28.936s (initrd) + 30.252s (userspace) = 1min 479ms. hub # [ 61.292418] tailscaled[660]: wgengine: set DNS config again after major link change hub # [ 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] hub # [ 61.301251] tailscaled[660]: magicsock: 0 active derp conns hub # [ 61.305931] tailscaled[660]: router: portUpdate(port=41641, network=udp6) hub # [ 61.308202] tailscaled[660]: router: portUpdate(port=41641, network=udp4) hub # [ 61.310156] tailscaled[660]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 61.312565] tailscaled[660]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 61.530847] headscale-start[877]: 2026-08-30T18:04:54Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 61.536838] headscale-start[877]: 2026-08-30T18:04:54Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 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 exceeded hub # [ 61.595697] tailscaled[660]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 61.602674] tailscaled[660]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 64.613266] tailscaled[660]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 64.621237] tailscaled[660]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 67.625360] tailscaled[660]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 67.634284] tailscaled[660]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 70.639748] tailscaled[660]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 70.645943] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ... hub # [ 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.key hub # [ 71.672461] headscale-start[877]: 2026-08-30T18:05:04Z INF starting headscale commit=v0.29.3 version=0.29.3 hub # [ 71.674774] headscale-start[877]: 2026-08-30T18:05:04Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 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]} hub # [ 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} hub # [ 71.715545] headscale-start[877]: 2026-08-30T18:05:04Z INF stun server started at [::]:3478 hub # [ 71.719820] headscale-start[877]: 2026-08-30T18:05:04Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 71.741607] headscale-start[877]: 2026-08-30T18:05:04Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 71.747907] headscale-start[877]: 2026-08-30T18:05:04Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 71.750850] headscale-start[877]: 2026-08-30T18:05:04Z INF metrics server disabled (metrics_listen_addr is empty) hub # [ 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 exceeded hub # [ 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" hub # [ 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... worker # Disk image does not exist, creating the virtualisation disk image... worker # Formatting '/build/vm-state-worker/tmp.JXMnSJlmJ0', fmt=raw size=1073741824 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/262144 done worker # Creating filesystem with 262144 4k blocks and 65536 inodes worker: QEMU running (pid 48) worker # Filesystem UUID: b7a37648-fe9e-4602-ac29-1c377ee82bd8 worker # Superblock backups stored on blocks: worker # 32768, 98304, 163840, 229376 worker # worker # Allocating group tables: 0/8 done worker # Writing inode tables: 0/8 done worker # Creating journal (8192 blocks): done worker # Writing superblocks and filesystem accounting information: 0/8 done worker # worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. (finished: start all VMs, in 137.62 seconds) hub: waiting for unit headscale hub: waiting for the VM to finish booting hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub: (connecting took 0.00 seconds) hub: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) worker # worker # worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC590+7EF2C590 CA00 hub: (finished: waiting for unit headscale, in 0.23 seconds) hub: waiting for TCP port 443 on localhost worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC590 7EF2C590 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)... worker # worker # worker # Booting from ROM... hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.15 seconds) hub: waiting for unit tailscaled worker # Probing EDD (edd=off to disable)... ok hub: (finished: waiting for unit tailscaled, in 0.09 seconds) worker: waiting for unit tailscaled worker: waiting for the VM to finish booting worker # [ 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 2026 worker # [ 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=tty0 worker # [ 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. worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd4fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd5000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved worker # [ 0.000000] NX (Execute Disable) protection: active worker # [ 0.000000] APIC: Static calls initialized worker # [ 0.000000] SMBIOS 2.8 present. worker # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 worker # [ 0.000000] DMI: Memory slots populated: 1/1 worker # [ 0.000000] Hypervisor detected: KVM worker # [ 0.000000] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000001] kvm-clock: using sched offset of 723610742 cycles worker # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000007] tsc: Detected 3099.998 MHz processor worker # [ 0.000967] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.001003] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.001007] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.003283] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.003302] Using GB pages for direct mapping worker # [ 0.003439] RAMDISK: [mem 0x7e360000-0x7ffcffff] worker # [ 0.003448] ACPI: Early table checksum verification disabled worker # [ 0.003452] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) worker # [ 0.003457] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003463] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003472] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003476] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.003479] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003482] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003485] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003488] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.003491] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d] worker # [ 0.003492] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219] worker # [ 0.003493] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.003494] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385] worker # [ 0.003495] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd] worker # [ 0.003496] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9] worker # [ 0.003496] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421] worker # [ 0.003949] No NUMA configuration found worker # [ 0.003951] Faking a node at [mem 0x0000000000000000-0x000000007ffd4fff] worker # [ 0.003954] NODE_DATA(0) allocated [mem 0x7e35aa80-0x7e35ffff] worker # [ 0.004048] Zone ranges: worker # [ 0.004049] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.004051] DMA32 [mem 0x0000000001000000-0x000000007ffd4fff] worker # [ 0.004052] Normal empty worker # [ 0.004053] Device empty worker # [ 0.004054] Movable zone start for each node worker # [ 0.004054] Early memory node ranges worker # [ 0.004055] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.004056] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.004057] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd4fff] worker # [ 0.004078] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.004351] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.042722] On node 0, zone DMA32: 43 pages in unavailable ranges worker # [ 0.043727] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.043744] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.043775] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.043778] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.043780] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.043781] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.043782] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.043783] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.043786] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.043787] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.043793] TSC deadline timer available worker # [ 0.043798] CPU topo: Max. logical packages: 1 worker # [ 0.043799] CPU topo: Max. logical dies: 1 worker # [ 0.043800] CPU topo: Max. dies per package: 1 worker # [ 0.043804] CPU topo: Max. threads per core: 1 worker # [ 0.043805] CPU topo: Num. cores per package: 1 worker # [ 0.043806] CPU topo: Num. threads per package: 1 worker # [ 0.043806] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.043831] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.043872] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.043873] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.043875] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.043877] Booting paravirtualized kernel on KVM worker # [ 0.043882] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.049034] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.052524] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.052592] kvm-guest: PV spinlocks disabled, single CPU worker # [ 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=tty0 worker # [ 0.052730] Unknown kernel command line parameters "regInfo=/nix/store/mpzwiw4bqr8ybpllmvpi3bjc25rv2wf5-closure-info/registration", will be passed to user space. worker # [ 0.052751] random: crng init done worker # [ 0.052752] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.056183] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.057320] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.057361] Fallback order for Node 0: 0 worker # [ 0.057365] Built 1 zonelists, mobility grouping on. Total pages: 524147 worker # [ 0.057367] Policy zone: DMA32 worker # [ 0.060281] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.067523] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.073031] allocated 4194304 bytes of page_ext worker # [ 0.083837] ftrace: allocating 48731 entries in 192 pages worker # [ 0.083842] ftrace: allocated 192 pages with 2 groups worker # [ 0.084839] Dynamic Preempt: lazy worker # [ 0.085046] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.085047] rcu: RCU event tracing is enabled. worker # [ 0.085048] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.085049] Trampoline variant of Tasks RCU enabled. worker # [ 0.085050] Rude variant of Tasks RCU enabled. worker # [ 0.085050] Tracing variant of Tasks RCU enabled. worker # [ 0.085051] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.085052] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.085077] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.085079] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.085080] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.090767] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.091078] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.091087] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.091205] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.098029] Console: colour VGA+ 80x25 worker # [ 0.098033] printk: legacy console [tty0] enabled worker # [ 0.143298] printk: legacy console [ttyS0] enabled worker # [ 0.317150] ACPI: Core revision 20250807 worker # [ 0.318663] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.321441] APIC: Switch to symmetric I/O mode setup worker # [ 0.322969] x2apic enabled worker # [ 0.324172] APIC: Switched APIC routing to: physical x2apic worker # [ 0.326927] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.328932] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.331811] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) worker # [ 0.332892] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.334967] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.335808] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.336813] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.337808] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.339807] Spectre V2 : Mitigation: Retpolines worker # [ 0.340807] RETBleed: Mitigation: untrained return thunk worker # [ 0.341807] Speculative Return Stack Overflow: Mitigation: SMT disabled worker # [ 0.343807] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.344807] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT worker # [ 0.345807] Spectre V2 : Enabling Speculation Barrier for firmware calls worker # [ 0.346807] active return thunk: retbleed_return_thunk worker # [ 0.347811] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.349829] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.351808] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.352808] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.354808] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.355807] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. worker # [ 0.382149] Freeing SMP alternatives memory: 44K worker # [ 0.382809] pid_max: default: 32768 minimum: 301 worker # [ 0.384820] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.385904] landlock: Up and running. worker # [ 0.387542] Yama: becoming mindful. worker # [ 0.388692] LSM support for eBPF active worker # [ 0.389944] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.390852] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.393089] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) worker # [ 0.394444] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.394817] ... version: 0 worker # [ 0.395809] ... bit width: 48 worker # [ 0.396809] ... generic counters: 6 worker # [ 0.397809] ... generic bitmap: 000000000000003f worker # [ 0.398808] ... fixed-purpose counters: 0 worker # [ 0.399808] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.400808] ... value mask: 0000ffffffffffff worker # [ 0.401808] ... max period: 00007fffffffffff worker # [ 0.402808] ... global_ctrl mask: 000000000000003f worker # [ 0.403937] signal: max sigframe size: 1776 worker # [ 0.404951] rcu: Hierarchical SRCU implementation. worker # [ 0.405813] rcu: Max phase no-delay instances is 400. worker # [ 0.411016] smp: Bringing up secondary CPUs ... worker # [ 0.411830] smp: Brought up 1 node, 1 CPU worker # [ 0.412811] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) worker # [ 0.414099] Memory: 1971572K/2096588K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115548K reserved, 0K cma-reserved) worker # [ 0.415346] devtmpfs: initialized worker # [ 0.416091] x86/mm: Memory block size: 128MB worker # [ 0.418029] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.418846] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.419976] pinctrl core: initialized pinctrl subsystem worker # [ 0.421190] PM: RTC time: 18:06:01, date: 2026-08-30 worker # [ 0.425738] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.427509] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.428855] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.430130] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.430833] audit: initializing netlink subsys (disabled) worker # [ 0.432222] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.432224] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.432809] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.433817] audit: type=2000 audit(1788113161.004:1): state=initialized audit_enabled=0 res=1 worker # [ 0.435816] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.435818] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.436863] cpuidle: using governor menu worker # [ 0.440056] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.441203] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.441815] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.443624] PCI: Using configuration type 1 for base access worker # [ 0.445169] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.452355] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.452810] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.453810] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.458811] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.474633] ACPI: Added _OSI(Module Device) worker # [ 0.475828] ACPI: Added _OSI(Processor Device) worker # [ 0.477820] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.483365] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.491155] ACPI: Interpreter enabled worker # [ 0.491831] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.496813] ACPI: Using IOAPIC for interrupt routing worker # [ 0.497942] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.502826] PCI: Using E820 reservations for host bridge windows worker # [ 0.504471] ACPI: Enabled 2 GPEs in block 00 to 3F worker # [ 0.523547] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.526819] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.527945] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.528929] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.532469] PCI host bridge to bus 0000:00 worker # [ 0.533778] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.536091] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.537812] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.538816] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.539810] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.540824] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] worker # [ 0.541816] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.544041] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.545736] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.548910] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.549844] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.550871] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.552079] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.554060] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.556827] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.557828] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.558890] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.559822] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.562269] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.565828] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.566822] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.567856] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.570240] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.572836] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.573824] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.574873] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.577249] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.579993] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.581836] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.582876] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.585233] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.587826] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.588825] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.589892] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.592050] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.594830] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.595850] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.596869] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.599302] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.602850] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.603828] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.604936] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.606935] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.609428] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.612888] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.614099] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] worker # [ 0.616000] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.618848] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.619825] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.620882] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.623247] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.625836] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f] worker # [ 0.626849] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.627857] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.630067] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.631872] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f] worker # [ 0.633237] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.634889] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f] worker # [ 0.636245] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.637880] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f] worker # [ 0.639328] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint worker # [ 0.641836] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.644456] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.646503] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 0.648453] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint worker # [ 0.651675] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf] worker # [ 0.652824] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] worker # [ 0.654573] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.656870] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] worker # [ 0.664289] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.664974] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.665980] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.666964] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.667975] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.668979] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 0.670017] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.670963] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.671887] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.672829] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.673828] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.674833] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 0.675842] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.676831] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.677849] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.678838] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 0.681307] iommu: Default domain type: Translated worker # [ 0.681822] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.683237] ACPI: bus type USB registered worker # [ 0.684048] usbcore: registered new interface driver usbfs worker # [ 0.684839] usbcore: registered new interface driver hub worker # [ 0.685840] usbcore: registered new device driver usb worker # [ 0.688061] NetLabel: Initializing worker # [ 0.688810] NetLabel: domain hash size = 128 worker # [ 0.689810] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.690942] NetLabel: unlabeled traffic allowed by default worker # [ 0.691839] PCI: Using ACPI for IRQ routing hub # [ 127.775484] tailscaled[660]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 127.783281] tailscaled[660]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ... worker # [ 0.791921] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.792804] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.792804] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.792827] vgaarb: loaded worker # [ 0.794076] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.794811] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.798995] clocksource: Switched to clocksource kvm-clock worker # [ 0.803537] VFS: Disk quotas dquot_6.6.0 worker # [ 0.804854] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.807100] pnp: PnP ACPI init worker # [ 0.808255] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 0.809806] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 0.812167] pnp: PnP ACPI: found 6 devices worker # [ 0.820425] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.822862] clocksource: Switched to clocksource acpi_pm worker # [ 0.824480] NET: Registered PF_INET protocol family worker # [ 0.826592] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.847066] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.849418] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.851538] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.853987] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) worker # [ 0.856152] TCP: Hash tables configured (established 16384 bind 16384) worker # [ 0.858176] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) worker # [ 0.860420] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.862393] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.864691] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.866527] NET: Registered PF_XDP protocol family worker # [ 0.868119] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.869840] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.871459] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.873341] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] worker # [ 0.875464] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 0.877400] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] worker # [ 0.880149] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 0.883089] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 0.885353] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 0.887980] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 0.890276] PCI: CLS 0 bytes, default 64 worker # [ 0.891923] Trying to unpack rootfs image as initramfs... worker # [ 0.898012] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.945264] Initialise system trusted keyrings worker # [ 0.949891] workingset: timestamp_bits=40 max_order=19 bucket_order=0 worker # [ 0.977300] Key type asymmetric registered worker # [ 0.981802] Asymmetric key parser 'x509' registered worker # [ 0.986866] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.992839] io scheduler mq-deadline registered worker # [ 0.997798] io scheduler kyber registered worker # [ 1.001360] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 1.007268] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 1.014421] Linux agpgart interface v0.103 worker # [ 1.017918] ACPI: bus type drm_connector registered worker # [ 1.022061] usbcore: registered new interface driver usbserial_generic worker # [ 1.023842] usbserial: USB Serial support registered for generic worker # [ 1.028809] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 1.031240] drop_monitor: Initializing network drop monitor service worker # [ 1.037988] NET: Registered PF_INET6 protocol family worker # [ 1.040127] Segment Routing with IPv6 worker # [ 1.044811] In-situ OAM (IOAM) with IPv6 worker # [ 1.046570] IPI shorthand broadcast: enabled worker # [ 1.057232] sched_clock: Marking stable (823028201, 233718797)->(1289498116, -232751118) worker # [ 1.063092] registered taskstats version 1 worker # [ 1.064628] Loading compiled-in X.509 certificates worker # [ 1.079509] Demotion targets for Node 0: null worker # [ 1.084042] Key type .fscrypt registered worker # [ 1.087791] Key type fscrypt-provisioning registered worker # [ 1.089988] ima: No TPM chip found, activating TPM-bypass! worker # [ 1.095789] ima: Allocated hash algorithm: sha1 worker # [ 1.097285] ima: No architecture policies found worker # [ 1.102031] PM: Magic number: 6:243:141 worker # [ 1.103337] acpi device:12: hash matches worker # [ 1.109184] RAS: Correctable Errors collector initialized. worker # [ 1.125135] clk: Disabling unused clocks worker # [ 1.129789] PM: genpd: Disabling unused power domains worker # [ 1.458248] Freeing initrd memory: 29120K worker # [ 1.465144] Freeing unused decrypted memory: 2028K worker # [ 1.470023] Freeing unused kernel image (initmem) memory: 3644K worker # [ 1.472280] Write protecting the kernel read-only data: 32768k worker # [ 1.475379] Freeing unused kernel image (text/rodata gap) memory: 1216K worker # [ 1.478356] Freeing unused kernel image (rodata/data gap) memory: 756K worker # [ 1.538937] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.541292] Run /init as init process worker # [ 1.555191] systemd[1]: Inserted module 'autofs4' worker # [ 1.582876] fuse: init (API version 7.45) worker # [ 1.590172] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.593870] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.599081] ACPI: \_SB_.GSIE: Enabled at IRQ 20 worker # [ 1.603351] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.641030] systemd[1]: Successfully made /usr/ read-only. worker # [ 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) worker # [ 1.987642] systemd[1]: Detected virtualization kvm. worker # [ 1.989789] systemd[1]: Detected architecture x86-64. worker # [ 1.991323] systemd[1]: Running in initrd. worker # [ 1.993518] systemd[1]: Initializing machine ID from random generator. worker # [ 1.995598] systemd[1]: Hostname set to . worker # [ 2.197127] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.250156] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 2.255638] systemd[1]: Created slice Slice /system/modprobe. worker # [ 2.257745] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 2.259998] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 2.261935] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 2.263827] systemd[1]: Reached target Path Units. worker # [ 2.265275] systemd[1]: Reached target Slice Units. worker # [ 2.266884] systemd[1]: Reached target Swaps. worker # [ 2.268202] systemd[1]: Reached target Timer Units. worker # [ 2.269960] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 2.272244] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 2.274448] systemd[1]: Listening on Journal Sockets. worker # [ 2.276396] systemd[1]: Listening on udev Control Socket. worker # [ 2.278227] systemd[1]: Listening on udev Kernel Socket. worker # [ 2.279840] systemd[1]: Reached target Socket Units. worker # [ 2.282554] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 2.292054] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 2.301828] systemd[1]: Starting Load Kernel Module configfs... worker # [ 2.311818] systemd[1]: Starting Journal Service... worker # [ 2.325826] systemd[1]: Starting Load Kernel Modules... worker # [ 2.333682] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.346260] netfs: FS-Cache loaded worker # [ 2.349979] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.371636] 9pnet: Installing 9P2000 support worker # [ 2.374874] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.388978] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.403782] systemd-journald[68]: Collecting audit messages is disabled. worker # [ 2.408047] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.421076] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.423840] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.430412] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.442433] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.452615] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.466820] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 2.483928] systemd[1]: Finished Load Kernel Modules. worker # [ 2.496852] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.518899] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.533972] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.554758] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.347393] systemd-modules-load[69]: Inserted module 'dm_mod'[ 2.583346] systemd[1]: Started Journal Service. worker # worker # [ 2.353714] systemd-modules-load[69]: Inserted module 'virtio_balloon' worker # [ 2.356698] systemd-modules-load[69]: Inserted module 'virtio_gpu' worker # [ 2.363368] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.377135] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.381122] systemd[1]: Reached target Local File Systems. worker # [ 2.384423] systemd[1]: Starting Create System Files and Directories... worker # [ 2.395822] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.431230] systemd[1]: Finished Create System Files and Directories. worker # [ 2.445793] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.452620] systemd-udevd[83]: Using default interface naming scheme 'v261'. worker # [ 2.472117] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.473935] systemd[1]: Reached target System Initialization. worker # [ 2.475426] systemd[1]: Reached target Basic System. worker # [ 2.985382] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.989077] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 3.014779] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # [ 3.021379] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 3.031127] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 3.032311] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 worker # [ 3.035151] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 worker # [ 3.043784] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 3.046285] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 3.047605] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 3.050751] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.053620] usb usb1: Product: EHCI Host Controller worker # [ 3.055767] usb usb1: Manufacturer: Linux 6.18.46 ehci_hcd worker # [ 3.057330] usb usb1: SerialNumber: 0000:00:1d.7 worker # [ 3.060012] hub 1-0:1.0: USB hub found worker # [ 3.061498] hub 1-0:1.0: 6 ports detected worker # [ 3.067374] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 3.072968] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 3.077290] virtio_blk virtio5: [vdb] 2136112 512-byte logical blocks (1.09 GB/1.02 GiB) worker # [ 3.083294] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 worker # [ 3.099937] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 3.103286] SCSI subsystem initialized worker # [ 3.106663] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c240 worker # [ 3.115022] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.116742] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.911200] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.914397] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.917867] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. worker # [ 3.157438] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 3.160739] usb usb2: Product: UHCI Host Controller worker # [ 2.934552] systemd[1]: Starting Virtual Console Setup... worker # [ 3.179525] usb usb2: Manufacturer: Linux 6.18.46 uhci_hcd worker # [ 3.198407] usb usb2: SerialNumber: 0000:00:1d.0 worker # [ 3.203796] hub 2-0:1.0: USB hub found worker # [ 2.980411] systemd-vconsole-setup[106]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.986587] systemd[1]: Finished Virtual Console Setup. worker # [ 3.223761] hub 2-0:1.0: 2 ports detected worker # [ 3.233262] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 3.234376] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 3.004376] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 3.006874] systemd[1]: Reached target Initrd Root Device. worker # [ 3.009286] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 3.257775] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 3.026213] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 3.262436] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c260 worker # [ 3.268980] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.270807] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.274268] usb usb3: Product: UHCI Host Controller worker # [ 3.045359] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 3.283547] usb usb3: Manufacturer: Linux 6.18.46 uhci_hcd worker # [ 3.284799] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 3.287904] hub 3-0:1.0: USB hub found worker # [ 3.290150] hub 3-0:1.0: 2 ports detected worker # [ 3.295349] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 3.297137] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 3.298148] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 3.300297] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 3.301742] usb 1-1: new high-speed USB device number 2 using ehci-pci worker # [ 3.303463] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 3.304625] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c280 worker # [ 3.306372] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 3.310864] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 3.313384] scsi host0: ahci worker # [ 3.315167] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 3.317035] scsi host1: ahci worker # [ 3.318898] scsi host2: ahci worker # [ 3.320778] usb usb4: Product: UHCI Host Controller worker # [ 3.321677] usb usb4: Manufacturer: Linux 6.18.46 uhci_hcd worker # [ 3.323132] scsi host3: ahci worker # [ 3.324985] scsi host4: ahci worker # [ 3.326875] scsi host5: ahci worker # [ 3.327584] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 worker # [ 3.329848] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 3.331555] hub 4-0:1.0: USB hub found worker # [ 3.332797] hub 4-0:1.0: 2 ports detected worker # [ 3.333660] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 worker # [ 3.342759] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 worker # [ 3.344276] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 worker # [ 3.355640] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 worker # [ 3.359937] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 worker # [ 3.433838] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.435338] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.437191] usb 1-1: Product: QEMU USB Tablet worker # [ 3.438281] usb 1-1: Manufacturer: QEMU worker # [ 3.439325] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 3.453301] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.668626] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 3.670036] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.671571] ata3.00: applying bridge limits worker # [ 3.672897] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 3.674275] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 3.675832] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 3.677243] ata2: SATA link down (SStatus 0 SControl 300) worker # [ 3.678609] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 3.679906] ata3.00: configured for UDMA/100 worker # [ 3.681258] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 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 exceeded hub # [ 130.784189] tailscaled[660]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 130.790990] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ... worker # [ 3.712043] usbcore: registered new interface driver usbhid worker # [ 3.715748] usbhid: USB HID core driver worker # [ 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/input2 worker # [ 3.724316] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 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/input0 worker # [ 3.736892] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 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 exceeded hub # [ 133.818864] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 133.829351] tailscaled[660]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 136.834673] tailscaled[660]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 136.841936] tailscaled[660]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 139.844628] tailscaled[660]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 139.851105] tailscaled[660]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 142.850381] tailscaled[660]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 142.856358] tailscaled[660]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ... hub # [ 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 exceeded worker # [ 20.463434] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 20.467795] systemd[1]: Mounting /sysroot... worker # [ 21.070810] EXT4-fs (vda): mounted filesystem b7a37648-fe9e-4602-ac29-1c377ee82bd8 r/w with ordered data mode. Quota mode: none. worker # [ 20.842858] systemd[1]: Mounted /sysroot. worker # [ 20.845981] systemd[1]: Reached target Initrd Root File System. worker # [ 20.853421] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 20.862173] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 20.869325] systemd[1]: Mounting /sysroot/run... worker # [ 20.894399] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 20.909298] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 20.932332] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 20.988716] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 21.225373] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 21.006386] systemd-sysroot-fstab-check[157]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 21.009434] systemd[1]: Mounted /sysroot/run. worker # [ 21.021134] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 21.258306] 9p: Installing v9fs 9p2000 file system support worker # [ 21.037264] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 21.039081] systemd[1]: Reload requested from client PID 157 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 21.042546] systemd[1]: Reloading... worker # [ 21.175980] systemd[1]: Reloading finished in 129 ms. worker # [ 21.193412] systemd-sysroot-fstab-check[157]: Requesting initrd-fs.target/start/replace... worker # [ 21.198860] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 21.201276] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 21.202615] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 21.205145] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 21.210445] systemd-sysroot-fstab-check[157]: Requesting swap.target/start/replace... worker # [ 21.214855] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 21.217372] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 21.219389] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 21.226234] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 21.241711] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 21.244783] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 21.464986] systemd[1]: Mounting /sysroot/nix/store... worker # [ 21.490583] systemd[1]: Mounted /sysroot/nix/store. worker # [ 21.492764] systemd[1]: Reached target Initrd File Systems. worker # [ 21.495622] systemd[1]: Starting Find NixOS closure... worker # [ 21.498826] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 21.524510] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 21.528976] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 21.540196] systemd[1]: Finished Find NixOS closure. worker # [ 21.543601] systemd[1]: Reached target Initrd Default Target. worker # [ 21.546300] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 21.567095] systemd[1]: Stopped target Initrd Default Target. worker # [ 21.568914] systemd[1]: Stopped target Basic System. worker # [ 21.571548] systemd[1]: Stopped target Initrd Root Device. worker # [ 21.573189] systemd[1]: Stopped target Path Units. worker # [ 21.574441] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 21.576671] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 21.579525] systemd[1]: Stopped target Slice Units. worker # [ 21.581247] systemd[1]: Stopped target Socket Units. worker # [ 21.583284] systemd[1]: Stopped target System Initialization. worker # [ 21.584897] systemd[1]: Stopped target Swaps. worker # [ 21.586824] systemd[1]: Stopped target Timer Units. worker # [ 21.588472] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 21.591282] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 21.592738] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 21.594672] systemd[1]: Stopped Find NixOS closure. worker # [ 21.596243] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 21.600177] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 21.601995] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 21.604833] systemd[1]: Stopped Apply Kernel Variables. worker # [ 21.606551] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 21.611390] systemd[1]: Stopped Load Kernel Modules. worker # [ 21.616962] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 21.620327] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 21.623300] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 21.625423] systemd[1]: Stopped Create System Files and Directories. worker # [ 21.626955] systemd[1]: Stopped target Local File Systems. worker # [ 21.630227] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 21.631974] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 21.634741] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 21.637153] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 21.640125] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 21.641993] systemd[1]: Stopped Virtual Console Setup. worker # [ 21.655154] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 21.660249] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 21.663541] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 21.667229] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 21.669716] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 21.675180] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 21.682169] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 21.684170] systemd[1]: Closed udev Control Socket. worker # [ 21.686760] systemd[1]: Starting Cleanup udev Database... worker # [ 21.689250] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 21.691124] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 21.692661] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 21.695249] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 21.696927] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 21.699233] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 21.714865] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 21.718334] systemd[1]: Finished Cleanup udev Database. worker # [ 21.720193] systemd[1]: Reached target Switch Root. worker # [ 21.722626] systemd[1]: Starting NixOS Activation... worker # [ 22.085856] initrd-nixos-activation-start[207]: booting system configuration /nix/store/j6lk78pska82akk1m713f61nnzkhq1wz-nixos-system-worker-test worker # [ 22.123209] initrd-nixos-activation-start[207]: running activation script... worker # [ 22.574698] initrd-nixos-activation-start[230]: setting up /etc... worker # [ 22.708135] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 22.712345] systemd[1]: Finished NixOS Activation. worker # [ 22.716454] systemd[1]: Starting Switch Root... worker # [ 22.737132] systemd[1]: Switching root. worker # [ 23.100034] systemd-journald[68]: Received SIGTERM from PID 1 (systemd). worker: Guest root shell did not produce any data yet... worker: To debug, enter the VM and run 'systemctl status backdoor.service'. worker # [ 41.849997] NET: Registered PF_VSOCK protocol family worker # [ 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) worker # [ 42.226095] systemd[1]: Detected virtualization kvm. worker # [ 42.227950] systemd[1]: Detected architecture x86-64. worker # [ 42.229445] systemd[1]: Detected first boot. worker # [ 42.231497] systemd[1]: Initializing machine ID from random generator. worker # [ 42.579653] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 51.882453] systemd[1]: Applying preset policy. worker # [ 52.259238] systemd[1]: Populated /etc with preset unit settings. worker # [ 52.360310] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 52.362331] systemd[1]: Stopped initrd-switch-root.service. worker # [ 52.365058] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 52.368352] systemd[1]: Created slice Slice /system/getty. worker # [ 52.370061] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 52.371904] systemd[1]: Created slice User and Session Slice. worker # [ 52.373294] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 52.374928] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 52.376512] systemd[1]: Expecting device /dev/hvc0... worker # [ 52.377586] systemd[1]: Expecting device /dev/ttyS0... worker # [ 52.378662] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 52.379810] systemd[1]: Stopped target initrd-fs.target. worker # [ 52.380851] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 52.381977] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 52.383261] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 52.384547] systemd[1]: Reached target Path Units. worker # [ 52.385581] systemd[1]: Reached target Remote File Systems. worker # [ 52.386764] systemd[1]: Reached target Slice Units. worker # [ 52.387820] systemd[1]: Reached target Swaps. worker # [ 52.389841] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 52.399335] systemd[1]: Listening on Process Core Dump Socket. worker # [ 52.401618] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 52.404376] systemd[1]: Listening on Factory Reset Management. worker # [ 52.405972] systemd[1]: Listening on Hostname Service Socket. worker # [ 52.409600] systemd[1]: Starting Journal Log Access Socket... worker # [ 52.411856] systemd[1]: Listening on Journal Audit Socket. worker # [ 52.414786] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 52.416629] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 52.418727] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 52.420663] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 52.424055] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 52.425612] systemd[1]: Listening on udev Control Socket. worker # [ 52.426886] systemd[1]: Listening on udev Varlink Socket. worker # [ 52.430076] systemd[1]: Mounting Huge Pages File System... worker # [ 52.436252] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 52.445307] systemd[1]: Mounting Kernel Debug File System... worker # [ 52.457341] systemd[1]: Mounting Kernel Trace File System... worker # [ 52.474463] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 52.486330] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 52.502300] systemd[1]: Starting Load Kernel Module configfs... worker # [ 52.504254] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 52.508962] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 52.511374] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 52.520293] systemd[1]: Mounting FUSE Control File System... worker # [ 52.523280] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 52.537307] systemd[1]: Starting Journal Service... worker # [ 52.544333] systemd[1]: Starting Load Kernel Modules... worker # [ 52.551262] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 52.558294] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 52.560298] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 52.571352] systemd[1]: Starting Coldplug All udev Devices... worker # [ 52.578979] systemd[1]: Listening on Journal Log Access Socket. worker # [ 52.582469] systemd[1]: Mounted Huge Pages File System. worker # [ 52.585516] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 52.588666] systemd[1]: Mounted Kernel Debug File System. worker # [ 52.592629] systemd[1]: Mounted Kernel Trace File System. worker # [ 52.598344] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 52.602838] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 52.608040] systemd[1]: Finished Load Kernel Module configfs. worker # [ 52.611786] systemd[1]: Mounted FUSE Control File System. worker # [ 52.620317] systemd[1]: Mounting Kernel Configuration File System... worker # [ 52.636364] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 52.650966] systemd[1]: Mounted Kernel Configuration File System. worker # [ 52.685387] loop: module loaded worker # [ 52.692268] EXT4-fs (vda): re-mounted b7a37648-fe9e-4602-ac29-1c377ee82bd8. worker # [ 52.696024] systemd[1]: Finished Load Kernel Modules. worker # [ 52.701745] systemd-journald[300]: Collecting audit messages is enabled. worker # [ 52.704394] systemd[1]: Starting Firewall... worker # [ 52.713331] systemd[1]: Starting Apply Kernel Variables... worker # [ 52.720279] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 52.723720] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 52.727355] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 52.739296] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 52.742302] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 52.782312] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 52.795295] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 52.827857] systemd[1]: Finished Apply Kernel Variables. worker # [ 52.841173] systemd[1]: Started Journal Service. worker # [ 52.617750] systemd[1]: Queued start job for default target Multi-User System. worker # [ 52.628280] systemd[1]: Unnecessary job was removed for /dev/vdb. worker # [ 52.645199] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 52.653422] systemd-modules-load[301]: Inserted module 'loop' worker # [ 52.660819] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 52.707269] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 52.710612] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 52.725124] systemd-oomd[302]: No swap; memory pressure usage will be degraded worker # [ 52.733181] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 52.734989] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 52.982438] systemd-journald[300]: Received client request to flush runtime journal. worker # [ 53.763852] systemd-udevd[332]: Using default interface naming scheme 'v261'. worker # [ 53.768563] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 53.774309] systemd[1]: Finished Coldplug All udev Devices. worker # [ 53.782367] systemd[1]: Mounting /run/wrappers... worker # [ 53.788170] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 53.793449] systemd[1]: Reached target First Boot Complete. worker # [ 53.800252] systemd[1]: Mounted /run/wrappers. worker # [ 53.806834] systemd[1]: Reached target Local File Systems. worker # [ 53.811385] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 53.814826] systemd[1]: Starting register-nix-paths.service... worker # [ 53.816675] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 53.820437] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 53.824598] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 53.828578] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 53.833690] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 53.840417] systemd[1]: Finished Firewall. worker # [ 53.841814] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 53.845566] systemd[1]: Finished Flush Journal to Persistent Storage. worker # [ 53.848626] systemd[1]: Starting Create System Files and Directories... worker # [ 53.881702] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 53.883592] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 53.907184] systemd[1]: Finished Create System Files and Directories. worker # [ 53.917354] systemd[1]: Starting Rebuild Journal Catalog... worker # [ 53.926125] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 53.993695] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 54.044215] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 54.050568] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 54.055390] systemd[1]: Starting Update is Completed... worker # [ 54.104348] systemd[1]: Finished Update is Completed. worker # [ 54.139762] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 54.167554] (udev-worker)[380]: Network interface NamePolicy= disabled on kernel command line. worker # [ 54.173593] (udev-worker)[388]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 54.178284] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line. worker # [ 54.335204] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 54.337485] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 54.341973] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 54.343496] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 54.347323] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 54.352282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 54.358313] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 54.360671] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 54.498209] systemd[1]: Finished register-nix-paths.service. worker # [ 54.886065] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 54.932462] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 54.952191] mousedev: PS/2 mouse device common for all mice worker # [ 54.955514] ACPI: button: Power Button [PWRF] worker # [ 54.731757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 54.740152] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 54.743208] systemd[1]: Reached target System Initialization. worker # [ 54.745290] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 54.747237] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 54.750803] systemd[1]: Reached target Timer Units. worker # [ 54.756219] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 54.757698] systemd[1]: Listening on Nix Daemon Socket. worker # [ 54.764307] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 54.766331] systemd[1]: Listening on tribuchet-agent@1.socket. worker # [ 54.771493] systemd[1]: Reached target Socket Units. worker # [ 54.781126] systemd[1]: Reached target Basic System. worker # [ 54.783310] systemd[1]: Started backdoor.service. worker # [ 54.786308] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 54.797450] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 54.800259] systemd[1]: Starting Post-Boot Actions... worker # [ 54.808826] systemd[1]: Started Reset console on configuration changes. worker # [ 54.812672] systemd[1]: Starting resolvconf update... worker # [ 54.826583] systemd[1]: Starting D-Bus System Message Bus... worker # [ 54.940740] systemd[1]: Finished Post-Boot Actions. worker # connecting to host... worker # [ 54.997801] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 55.003397] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 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" worker # [ 55.025930] systemd[1]: Reached target User and Group Name Lookups. worker # [ 55.027748] systemd[1]: Starting User Login Management... worker # [ 55.050461] systemd[1]: Finished Import lastlog data into lastlog2 database. worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 55.74 seconds) worker: (finished: waiting for the VM to finish booting, in 55.74 seconds) worker # [ 55.105438] dbus-broker-launch[591]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 55.113117] dbus-broker-launch[591]: NSS returned no entry for 'systemd-timesync' worker # [ 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" worker # [ 55.159187] systemd[1]: Started D-Bus System Message Bus. worker # [ 55.414728] Console: switching to colour dummy device 80x25 worker # [ 55.256915] dbus-broker-launch[591]: Ready worker # [ 55.507690] rtc_cmos 00:04: RTC can wake from S4 worker # [ 55.356543] systemd-logind[603]: New seat seat0. worker # [ 55.370441] systemd[1]: Started User Login Management. worker # [ 55.375406] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 55.377474] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 55.389902] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 55.393801] systemd[1]: Stopping User and Group Name Lookups... worker # [ 55.399400] systemd[1]: Starting linger-users.service... worker # [ 55.401877] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 55.411866] systemd[1]: nscd.service: Deactivated successfully. worker # [ 55.413940] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 55.418300] systemd[1]: nscd.service: Consumed 25ms CPU time over 632ms wall clock time, 6.9M memory peak, 5.5M read from disk. worker # [ 55.425486] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 55.675347] rtc_cmos 00:04: registered as rtc0 worker # [ 55.689793] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 55.691274] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 55.486301] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 55.721557] rtc_cmos 00:04: setting system clock to 2026-08-30T18:06:56 UTC (1788113216) worker # [ 55.491168] systemd[1]: Finished linger-users.service. worker # [ 55.736928] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 worker # [ 55.515498] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 55.517962] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 55.524072] systemd[1]: Reached target User and Group Name Lookups. worker # [ 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" worker # [ 55.764604] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 55.767616] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 55.768793] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 55.782560] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 55.553434] systemd[1]: Finished resolvconf update. worker # [ 55.555297] systemd[1]: Reached target Preparation for Network. worker # [ 55.563175] systemd[1]: Starting DHCP Client... worker # [ 55.579230] systemd[1]: Starting Address configuration of eth1... worker # [ 55.584398] systemd[1]: Starting Extra networking commands.... worker # [ 55.823311] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 55.596351] systemd[1]: Starting Tailscale node agent... worker # [ 55.808678] network-addresses-eth1-start[696]: adding address 192.168.1.2/24... done worker # [ 55.838154] network-addresses-eth1-start[696]: adding address 2001:db8:1::2/64... done worker # [ 55.876660] systemd[1]: Finished Address configuration of eth1. worker # [ 56.172553] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 56.302886] Console: switching to colour frame buffer device 160x50 worker # [ 56.342041] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 56.133983] dhcpcd[712]: dhcpcd-10.3.2 starting worker # [ 56.143370] dhcpcd[766]: dev: loaded udev worker # [ 56.394722] 8021q: 802.1Q VLAN Support v1.8 worker # [ 56.399591] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 56.171722] tailscaled[698]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 56.189812] systemd[1]: Finished Extra networking commands.. worker # [ 56.192305] systemd[1]: Reached target Network. worker # [ 56.203340] systemd[1]: Starting Permit User Sessions... worker # [ 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"} worker # [ 56.249632] tailscaled[698]: LogID: 0c367f3eb3d051f3b8452516528a0b6d5d6bbedfefabbe40f3ca44779a36590f worker # [ 56.251701] tailscaled[698]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 56.255328] tailscaled[698]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 56.262286] tailscaled[698]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 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. worker # [ 56.349155] systemd[1]: Finished Permit User Sessions. worker # [ 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... worker # [ 56.408117] tailscaled[698]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.428160] tailscaled[698]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.437227] tailscaled[698]: trying bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" ... worker # [ 56.454283] systemd[1]: Started Getty on tty1. worker # [ 56.690830] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 56.459778] systemd[1]: Reached target Login Prompts. worker # [ 56.702448] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 56.704572] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 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 unreachable worker # [ 56.714294] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 56.715879] cfg80211: failed to load regulatory.db worker # [ 56.493463] tailscaled[698]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.505255] tailscaled[698]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.511667] tailscaled[698]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.540811] tailscaled[698]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.547651] tailscaled[698]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.564692] tailscaled[698]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.575828] tailscaled[698]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ... worker # [ 56.578826] tailscaled[698]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 56.584120] tailscaled[698]: dns: using "openresolv" mode worker # [ 56.590140] tailscaled[698]: dns: using dns.openresolvManager worker # [ 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 unreachable worker # [ 56.614906] tailscaled[698]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 56.622625] tailscaled[698]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 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" worker # [ 56.908308] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 56.685136] dhcpcd[766]: eth0: waiting for carrier worker # [ 56.688092] dhcpcd[766]: eth0: carrier acquired worker # [ 56.709196] dhcpcd[766]: DUID 00:01:00:01:32:27:2d:c1:52:54:00:12:34:56 worker # [ 56.711580] dhcpcd[766]: eth0: IAID 00:12:34:56 worker # [ 56.713346] dhcpcd[766]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 56.884222] tailscaled[698]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found worker # [ 56.891056] systemd[1]: Started Tailscale node agent. worker # [ 56.895709] tailscaled[698]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 57.146896] tun: Universal TUN/TAP device driver, 1.6 worker # [ 57.159551] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 57.161714] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 57.028875] tailscaled[698]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 57.032754] tailscaled[698]: dns: using "openresolv" mode worker # [ 57.049510] tailscaled[698]: dns: using dns.openresolvManager worker # [ 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} worker # [ 57.065605] tailscaled[698]: router: portUpdate(port=41641, network=udp6) worker # [ 57.069218] tailscaled[698]: router: using firewall mode pref worker # [ 57.082160] tailscaled[698]: magicsock: disco key = d:5d2701f89d815c26 worker # [ 57.087394] tailscaled[698]: Creating WireGuard device... worker # [ 57.088791] tailscaled[698]: Bringing WireGuard device up... worker # [ 57.090382] tailscaled[698]: Bringing router up... worker # [ 57.326222] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 57.328457] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 57.135115] tailscaled[698]: external route: up worker # [ 57.154378] tailscaled[698]: router: default choosing iptables worker # [ 57.193537] tailscaled[698]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 57.196984] tailscaled[698]: router: portUpdate(port=41641, network=udp4) worker # [ 57.209401] tailscaled[698]: Clearing router settings... worker # [ 57.212726] tailscaled[698]: Starting network monitor... worker # [ 57.215192] tailscaled[698]: Engine created. worker # [ 57.243329] systemd[1]: Starting Virtual Console Setup... worker # [ 57.320735] systemd-logind[603]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 57.333814] systemd-logind[603]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 57.399113] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 57.405222] systemd[1]: Stopped Virtual Console Setup. worker # [ 57.418187] systemd[1]: Starting Virtual Console Setup... worker # [ 57.705740] ppdev: user-space parallel port driver worker # [ 57.528691] systemd-vconsole-setup[851]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 57.538237] systemd[1]: Finished Virtual Console Setup. worker # [ 57.544354] systemd-logind[603]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 57.560206] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 57.565194] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 57.568563] systemd[1]: Stopped Virtual Console Setup. worker # [ 57.570208] systemd[1]: Stopping Virtual Console Setup... worker # [ 57.575425] systemd[1]: Starting Virtual Console Setup... worker # [ 57.584229] (udev-worker)[798]: Network interface NamePolicy= disabled on kernel command line. worker # [ 57.829156] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 57.638679] systemd-vconsole-setup[855]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 57.647265] systemd[1]: Finished Virtual Console Setup. worker # [ 57.891429] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) worker: (finished: waiting for unit tailscaled, in 58.37 seconds) hub: must succeed: headscale users create test worker # [ 58.041276] kvm_amd: TSC scaling supported worker # [ 58.041867] kvm_amd: Nested Virtualization enabled worker # [ 58.043239] kvm_amd: Nested Paging enabled worker # [ 58.043827] kvm_amd: LBR virtualization supported worker # [ 58.044910] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 58.045982] kvm_amd: Virtual GIF supported worker # [ 58.078485] EDAC MC: Ver: 3.0.0 hub # [ 185.206636] headscale-start[877]: 2026-08-30T18:06:58Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 0.24 seconds) hub: must succeed: headscale preauthkeys -u 1 create --reusable worker # [ 58.056191] dhcpcd[766]: eth0: soliciting a DHCP lease worker # [ 58.117750] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 58.371687] NET: Registered PF_PACKET protocol family worker # [ 58.150970] dhcpcd[766]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 58.154431] dhcpcd[766]: eth0: probing address 10.0.2.15/24 hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.45 seconds) hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ALD49gnbVi06-PO9Gbdj-2h1Ng1rQ6-SOTp9AYLROxWj9rE_02vVH2WTht9GjFkibN-AMQqYEat2m --hostname hub hub # [ 185.845444] tailscaled[660]: localapi: [POST] /localapi/v0/check-prefs hub # [ 185.850081] tailscaled[660]: localapi: [POST] /localapi/v0/start hub # [ 185.851674] tailscaled[660]: control: client.Shutdown ... hub # [ 185.853269] tailscaled[660]: control: mapRoutine: exiting hub # [ 185.854758] tailscaled[660]: control: authRoutine: exiting hub # [ 185.856173] tailscaled[660]: control: updateRoutine: exiting hub # [ 185.861271] tailscaled[660]: control: Client.Shutdown done. hub # [ 185.863375] tailscaled[660]: Start hub # [ 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] hub # [ 185.876910] tailscaled[660]: generating new machine key worker # [ 58.926361] dhcpcd[766]: eth0: soliciting an IPv6 router worker # [ 58.928600] dhcpcd[766]: eth0: Router Advertisement from fe80::2 worker # [ 58.930242] dhcpcd[766]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 58.932217] dhcpcd[766]: eth0: adding route to fec0::/64 worker # [ 58.934256] dhcpcd[766]: eth0: adding default route via fe80::2 worker # [ 58.936115] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 58.938764] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 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] worker # [ 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] worker # [ 58.954589] tailscaled[698]: magicsock: 0 active derp conns worker # [ 58.956996] tailscaled[698]: router: portUpdate(port=41641, network=udp6) worker # [ 58.958785] tailscaled[698]: router: portUpdate(port=41641, network=udp4) worker # [ 59.118490] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 60.119717] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 60.349372] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 60.924986] tailscaled[698]: monitor: RTM_NEWROUTE: src=, dst=fec0::4530:a7b1:7f94:7e8d/128, gw=, outif=2, table=255 worker # [ 61.120628] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 62.125114] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 62.127574] tailscaled[698]: [RATELIMIT] format("tstun: tstun: awaiting Wrapper.Start call") worker # [ 62.683143] dhcpcd[766]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 62.685454] dhcpcd[766]: eth0: adding route to 10.0.2.0/24 worker # [ 62.688859] dhcpcd[766]: eth0: adding default route via 10.0.2.2 worker # [ 62.690527] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 62.692723] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 62.694988] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 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] worker # [ 62.714631] tailscaled[698]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 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] worker # [ 62.721122] tailscaled[698]: magicsock: 0 active derp conns worker # [ 62.725959] tailscaled[698]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 62.731875] tailscaled[698]: router: portUpdate(port=41641, network=udp6) worker # [ 62.735232] tailscaled[698]: router: portUpdate(port=41641, network=udp4) worker # [ 62.744360] tailscaled[698]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") worker # [ 62.792410] systemd[1]: Started DHCP Client. worker # [ 62.795431] systemd[1]: Reached target Multi-User System. worker # [ 62.797359] systemd[1]: Startup finished in 1.312s (kernel) + 40.275s (initrd) + 21.208s (userspace) = 1min 2.796s. worker # [ 68.131722] tailscaled[698]: [RATELIMIT] format("tstun: tstun: awaiting Wrapper.Start call") (5 dropped) worker # [ 68.133969] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 69.131933] tailscaled[698]: tstun: tstun: awaiting Wrapper.Start call worker # [ 69.133716] tailscaled[698]: [RATELIMIT] format("tstun: tstun: awaiting Wrapper.Start call") hub # [ 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... worker # [ 76.575943] tailscaled[698]: pm: migrating "_daemon" profile to new format worker # [ 76.649466] tailscaled[698]: envknob: PORT="41641" hub # [ 203.946993] tailscaled[660]: machine key written to store hub # [ 203.984963] tailscaled[660]: profile data directory: profile not found hub # [ 203.986947] tailscaled[660]: Backend: logs: be:ffc315636e6a75cc80db01f889b2957b18459eb86077209d1b728a42152a19e9 fe: hub # [ 204.000792] tailscaled[660]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 204.003874] tailscaled[660]: blockEngineUpdates(true) hub # [ 204.010257] tailscaled[660]: Reconfig(down): no changes made to Engine config worker # [ 76.661860] tailscaled[698]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 204.030458] tailscaled[660]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 204.042609] tailscaled[660]: health(warnable=wantrunning-false): ok worker # [ 76.718115] tailscaled[698]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 204.055553] tailscaled[660]: localapi: [POST] /localapi/v0/login-interactive hub # [ 204.057246] tailscaled[660]: StartLoginInteractiveAs("root"): url=false hub # [ 204.058695] tailscaled[660]: control: client.Login(2) hub # [ 204.069202] tailscaled[660]: control: LoginInteractive -> regen=true hub # [ 204.071347] tailscaled[660]: control: doLogin(regen=true, hasUrl=false) worker # [ 76.730700] tailscaled[698]: got LocalBackend in 19.829s worker # [ 76.766601] tailscaled[698]: Start worker # [ 76.770136] tailscaled[698]: ipnext: "conn25": skipping extension worker # [ 76.791824] tailscaled[698]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop worker # [ 76.808136] tailscaled[698]: profile data directory: profile not found worker # [ 76.810433] tailscaled[698]: Backend: logs: be:0c367f3eb3d051f3b8452516528a0b6d5d6bbedfefabbe40f3ca44779a36590f fe: worker # [ 76.813127] tailscaled[698]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 76.816291] tailscaled[698]: blockEngineUpdates(true) worker # [ 76.818723] tailscaled[698]: wgengine: Reconfig: configuring router worker # [ 76.820939] tailscaled[698]: wgengine: Reconfig: user dialer worker # [ 76.822629] tailscaled[698]: wgengine: Reconfig: configuring DNS worker # [ 76.824494] tailscaled[698]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 76.826769] tailscaled[698]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 76.828813] tailscaled[698]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 76.830991] tailscaled[698]: dns: OScfg: {} hub # [ 204.182931] tailscaled[660]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 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=200 hub # [ 204.218816] tailscaled[660]: control: control server key from https://hub: ts2021=[qFhKG], legacy= hub # [ 204.222610] tailscaled[660]: control: Generating a new nodekey. hub # [ 204.229980] tailscaled[660]: control: RegisterReq: onode= node=[SrAB0] fup=false nks=false hub # [ 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=200 hub # [ 205.093335] tailscaled[660]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 205.102838] tailscaled[660]: blockEngineUpdates(false) hub # [ 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=200 hub # [ 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=test hub # [ 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=test hub # [ 206.323755] tailscaled[660]: magicsock: new contact: control-netmap usec=152238962 cached=false hub # [ 206.327230] tailscaled[660]: active login: test hub # [ 206.365178] tailscaled[660]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 206.369714] tailscaled[660]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 206.374203] tailscaled[660]: magicsock: SetPrivateKey called (init) hub # [ 206.376805] tailscaled[660]: wgengine: Reconfig: configuring router hub # [ 206.607783] tailscaled[660]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [26ms] (forced=false) hub # [ 206.610584] tailscaled[660]: magicsock: home is now derp-999 () hub # [ 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) hub # [ 206.619894] tailscaled[660]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 206.626665] tailscaled[660]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 206.629226] tailscaled[660]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 206.640204] tailscaled[660]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 206.674436] tailscaled[660]: magicsock: derp-999 connected; connGen=1 hub # [ 207.349128] tailscaled[660]: router: enabling connmark-based rp_filter workaround hub # [ 207.552951] tailscaled[660]: wgengine: Reconfig: user dialer hub # [ 207.556392] tailscaled[660]: tsdial: bart table size: 2 hub # [ 207.559431] tailscaled[660]: wgengine: Reconfig: configuring DNS hub # [ 207.561077] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} hub # [ 207.716648] tailscaled[660]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} hub # [ 207.719642] tailscaled[660]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 207.895871] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 207.901858] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 207.907136] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 207.909330] systemd[1]: Stopping User and Group Name Lookups... hub # [ 207.913458] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 207.937383] systemd[1]: nscd.service: Deactivated successfully. hub # [ 207.946210] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 207.982782] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 208.066166] tailscaled[660]: peerapi: serving on http://100.64.0.1:58436 hub # [ 208.069412] tailscaled[660]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 208.083825] tailscaled[660]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 208.088352] tailscaled[660]: updating netmap in disk cache hub # [ 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=200 hub # [ 208.105658] tailscaled[660]: health(warnable=warming-up): ok hub # [ 208.111133] tailscaled[660]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub: (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) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ALD49gnbVi06-PO9Gbdj-2h1Ng1rQ6-SOTp9AYLROxWj9rE_02vVH2WTht9GjFkibN-AMQqYEat2m --hostname tt-worker hub # [ 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" hub # [ 208.167952] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 208.172932] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 208.175694] systemd[1]: Reached target User and Group Name Lookups. worker # [ 80.863569] tailscaled[698]: localapi: [POST] /localapi/v0/check-prefs worker # [ 80.866558] tailscaled[698]: localapi: [POST] /localapi/v0/start worker # [ 80.868597] tailscaled[698]: control: client.Shutdown ... worker # [ 80.870064] tailscaled[698]: control: mapRoutine: exiting worker # [ 80.872130] tailscaled[698]: control: authRoutine: exiting worker # [ 80.873966] tailscaled[698]: control: updateRoutine: exiting worker # [ 80.878242] tailscaled[698]: control: Client.Shutdown done. worker # [ 80.880717] tailscaled[698]: Start worker # [ 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] worker # [ 80.893933] tailscaled[698]: generating new machine key hub # [ 208.540452] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 208.548618] tailscaled[660]: trying bootstrapDNS("derp8d.tailscale.com", "2a03:b0c0:1:d0::e08:e001") for "log.tailscale.com" ... hub # [ 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=200 hub # [ 209.278815] tailscaled[660]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 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 exceeded hub # [ 211.554819] tailscaled[660]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 211.567477] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 214.572733] tailscaled[660]: trying bootstrapDNS("derp8b.tailscale.com", "46.101.74.201") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 214.579208] tailscaled[660]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 217.588511] tailscaled[660]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 217.595971] tailscaled[660]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 220.597689] tailscaled[660]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 220.604591] tailscaled[660]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 223.613298] tailscaled[660]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 223.620942] tailscaled[660]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ... hub # [ 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 exceeded worker # [ 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... worker # [ 112.657513] tailscaled[698]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 112.664764] tailscaled[698]: trying bootstrapDNS("derp5.tailscale.com", "2001:19f0:5801:10b7:5400:2ff:feaa:284c") for "log.tailscale.com" ... worker # [ 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 exceeded worker # [ 115.673784] tailscaled[698]: trying bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 115.681680] tailscaled[698]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ... worker # [ 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 exceeded worker # [ 118.681793] tailscaled[698]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 118.688186] tailscaled[698]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ... worker # [ 119.209205] tailscaled[698]: machine key written to store worker # [ 119.210561] tailscaled[698]: profile data directory: profile not found worker # [ 119.211830] tailscaled[698]: Backend: logs: be:0c367f3eb3d051f3b8452516528a0b6d5d6bbedfefabbe40f3ca44779a36590f fe: worker # [ 119.215450] tailscaled[698]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 119.218790] tailscaled[698]: blockEngineUpdates(true) worker # [ 119.220242] tailscaled[698]: Reconfig(down): no changes made to Engine config worker # [ 119.223421] tailscaled[698]: localapi: [POST] /localapi/v0/login-interactive worker # [ 119.226423] tailscaled[698]: StartLoginInteractiveAs("root"): url=false worker # [ 119.228821] tailscaled[698]: control: client.Login(2) worker # [ 119.235181] tailscaled[698]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 119.237407] tailscaled[698]: health(warnable=wantrunning-false): ok worker # [ 119.238781] tailscaled[698]: control: LoginInteractive -> regen=true worker # [ 119.240937] tailscaled[698]: control: doLogin(regen=true, hasUrl=false) worker # [ 119.600209] tailscaled[698]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 119.604690] tailscaled[698]: control: control server key from https://hub: ts2021=[qFhKG], legacy= hub # [ 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=200 worker # [ 119.606936] tailscaled[698]: control: Generating a new nodekey. worker # [ 119.611112] tailscaled[698]: control: RegisterReq: onode= node=[/cB+u] fup=false nks=false worker # [ 120.502542] tailscaled[698]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 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=200 worker # [ 120.506997] tailscaled[698]: blockEngineUpdates(false) hub # [ 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=200 hub # [ 248.510150] tailscaled[660]: wgengine: Reconfig: configuring router hub # [ 248.513722] tailscaled[660]: wgengine: Reconfig: user dialer hub # [ 248.515894] tailscaled[660]: tsdial: bart table size: 4 hub # [ 248.517887] tailscaled[660]: wgengine: Reconfig: configuring DNS hub # [ 248.519274] tailscaled[660]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} hub # [ 248.568623] tailscaled[660]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} hub # [ 248.572744] tailscaled[660]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 248.776345] tailscaled[660]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 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=200 hub # [ 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=test hub # [ 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=test worker # [ 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 exceeded worker # [ 121.691198] tailscaled[698]: trying bootstrapDNS("derp1d.tailscale.com", "165.22.33.71") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 121.699660] tailscaled[698]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... hub # [ 249.282051] tailscaled[660]: [RATELIMIT] format("control: [v\x00JSON]%d%s") worker # [ 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 exceeded worker # [ 124.699940] tailscaled[698]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 124.706299] tailscaled[698]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ... worker # [ 126.953170] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (5.000798145s elapsed) worker # [ 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 exceeded worker # [ 127.708270] tailscaled[698]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ... worker # [ 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 unreachable worker # [ 127.714621] tailscaled[698]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... worker # [ 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 exceeded worker # [ 131.956266] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (10.003739859s elapsed) worker # [ 136.956724] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (15.004036265s elapsed) hub # [ 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=0 hub # [ 266.708547] tailscaled[660]: magicsock: [0x1e3c1f283340] derp.Recv(derp-999): derp.Recv: EOF hub # [ 266.730521] tailscaled[660]: derphttp.Client.Recv: connecting to derp-999 () hub # [ 266.751165] tailscaled[660]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 266.804406] tailscaled[660]: magicsock: derp-999 connected; connGen=2 worker # [ 141.960443] tailscaled[698]: tailscale.com/ipn/ipnlocal local.go:702: subscriber for controlclient.AutoUpdate is slow (20.007961344s elapsed) worker # [ 146.198571] tailscaled[698]: magicsock: new contact: control-netmap usec=89139240 cached=false worker # [ 146.201375] tailscaled[698]: active login: test worker # [ 146.250184] tailscaled[698]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 146.253408] tailscaled[698]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 146.255688] tailscaled[698]: magicsock: SetPrivateKey called (init) worker # [ 146.258120] tailscaled[698]: wgengine: Reconfig: configuring router worker # [ 146.458697] tailscaled[698]: router: enabling connmark-based rp_filter workaround worker # [ 146.462211] tailscaled[698]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [2ms] (forced=false) worker # [ 146.467148] tailscaled[698]: magicsock: home is now derp-999 () worker # [ 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) worker # [ 146.473189] tailscaled[698]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 146.475318] tailscaled[698]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 146.477989] tailscaled[698]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 146.487679] tailscaled[698]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 146.497975] tailscaled[698]: magicsock: derp-999 connected; connGen=1 worker # [ 146.513163] tailscaled[698]: wgengine: Reconfig: user dialer worker # [ 146.515327] tailscaled[698]: tsdial: bart table size: 4 worker # [ 146.516557] tailscaled[698]: wgengine: Reconfig: configuring DNS worker # [ 146.518194] tailscaled[698]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} worker # [ 146.537856] tailscaled[698]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} worker # [ 146.540425] tailscaled[698]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 146.586955] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 146.590890] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 146.593670] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 146.597873] systemd[1]: Stopping User and Group Name Lookups... worker # [ 146.601403] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 146.603723] systemd[1]: nscd.service: Deactivated successfully. worker # [ 146.607944] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 146.628367] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 146.647666] tailscaled[698]: peerapi: serving on http://100.64.0.2:46590 worker # [ 146.652109] tailscaled[698]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 146.653518] tailscaled[698]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 146.659485] tailscaled[698]: health(warnable=warming-up): ok worker # [ 146.663307] tailscaled[698]: updating netmap in disk cache worker # [ 146.672819] tailscaled[698]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 146.686955] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 146.692079] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 146.693644] systemd[1]: Reached target User and Group Name Lookups. worker # [ 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" worker: (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) ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker: waiting for success: tailscale ping hub ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker # [ 146.749275] tailscaled[698]: localapi: [POST] /localapi/v0/ping worker # [ 146.750715] tailscaled[698]: ping(100.64.0.1): sending disco ping to [SrAB0] hub ... worker # [ 146.753400] tailscaled[698]: magicsock: disco: node [SrAB0] d:2e9d1052a7d56760 now using [2001:db8:1::1]:41641 mtu=1360 tx=50aa36b61bec worker # [ 146.757475] tailscaled[698]: magicsock: new contact: peer=[SrAB0] usec=89701055 cached=false via=direct worker: (finished: waiting for success: tailscale ping hub, in 0.06 seconds) hub: must succeed: tailscale ip -4 hub: (finished: must succeed: tailscale ip -4, in 0.12 seconds) worker: 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 worker # [ 146.928731] tailscaled[698]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker: (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) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 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=200 hub # [ 274.515953] systemd[1]: Starting tribuchet-hub.socket... hub # [ 274.549209] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 274.570094] systemd[1]: Starting tribuchet-hub.service... hub # [ 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=[] hub # [ 274.752399] tribuchet[1081]: 2026-08-30T18:08:27.881817Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 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.sock hub # [ 274.778921] systemd[1]: Started tribuchet-hub.service. hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.69 seconds) worker: must succeed: systemctl start tribuchet-worker hub # [ 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=200 worker # [ 147.679237] systemd[1]: Starting tribuchet-worker.service... worker # [ 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 } worker # [ 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") worker # [ 147.778586] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.14 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' worker # [ 147.788888] systemd[1]: Started tribuchet-agent@1.service. worker # [ 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=65536 worker # [ 147.819748] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:28.831134Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 147.824242] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:28.831198Z INFO tribuchet::worker::agent: agent listening uid=995 hub # [ 275.171607] tailscaled[660]: magicsock: disco: node [/cB+u] d:5d2701f89d815c26 now using [2001:db8:1::2]:41641 mtu=1360 tx=482d1389c85e hub # [ 275.174835] tailscaled[660]: magicsock: new contact: peer=[/cB+u] usec=221086550 cached=false via=direct hub # [ 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"] }] worker # [ 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"] hub # [ 275.588214] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 275.590353] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.18 seconds) subtest: a build dispatches over the tailnet hub: must succeed: echo tailscale-auth-payload > /root/payload hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.08 seconds) hub: must succeed: nix-store --add /root/payload worker # [ 149.751129] tailscaled[698]: magicsock: disco: node [SrAB0] d:2e9d1052a7d56760 now using 192.168.1.1:41641 mtu=1360 tx=623898a55276 hub # [ 277.083763] tailscaled[660]: magicsock: disco: node [/cB+u] d:5d2701f89d815c26 now using 192.168.1.2:41641 mtu=1360 tx=f692b5afb89d hub # [ 280.580657] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 280.582905] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 297.321261] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 297.325543] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 297.329333] tailscaled[660]: [RATELIMIT] format("dns udp query: %v") hub # [ 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... hub # [ 297.346165] tailscaled[660]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 297.485973] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ... hub # [ 297.488959] tailscaled[660]: [RATELIMIT] format("dns udp query: %v") (2 dropped) hub # [ 297.498487] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 297.500632] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 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 unreachable hub # [ 297.506381] tailscaled[660]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ... hub # [ 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=200 hub # [ 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 exceeded hub # [ 298.594944] tailscaled[660]: trying bootstrapDNS("derp9b.tailscale.com", "144.202.67.195") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 298.601966] tailscaled[660]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ... worker # [ 171.445372] tailscaled[698]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 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=200 hub: (finished: must succeed: nix-store --add /root/payload, in 23.43 seconds) hub: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/7a60q5dgnv6z96c279rc1nalyiw4mgqn-bash-interactive-5.3p15"; unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload"; in derivation { name = "tt-tailscale"; system = "x86_64-linux"; builder = bash + "/bin/bash"; args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ]; } EOF hub: (finished: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/7a60q5dgnv6z96c279rc1nalyiw4mgqn-bash-interactive-5.3p15"; unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload"; in derivation { name = "tt-tailscale"; system = "x86_64-linux"; builder = bash + "/bin/bash"; args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ]; } EOF, in 0.04 seconds) hub: must succeed: nix-build /root/test.nix --no-out-link hub # this derivation will be built: hub # /nix/store/cvz23131m26jpbalbxk88f5sds5xnfkc-tt-tailscale.drv hub # building '/nix/store/cvz23131m26jpbalbxk88f5sds5xnfkc-tt-tailscale.drv'... hub # [ 300.293080] tribuchet[1081]: 2026-08-30T18:08:53.424902Z INFO tribuchet::hub::submit: queueing build id="32c9671be459ece7e8f25ecf1e6842a3" system="x86_64-linux" hub # [ 300.297197] tribuchet[1081]: 2026-08-30T18:08:53.429611Z INFO tribuchet::hub: dispatching build id="32c9671be459ece7e8f25ecf1e6842a3" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 172.982603] tribuchet[1096]: 2026-08-30T18:08:53.991869Z INFO tribuchet::worker::session: build assigned id="32c9671be459ece7e8f25ecf1e6842a3" worker # [ 172.989892] systemd[1]: Started Nix Daemon. worker # [ 173.030876] nix-daemon[1103]: accepted connection from pid 1096, user tribuchet (trusted) hub # [ 300.368592] tribuchet[1081]: 2026-08-30T18:08:53.500942Z INFO tribuchet::hub::relay::staging: input path negotiation done id="32c9671be459ece7e8f25ecf1e6842a3" total=8 missing=1 hub # [ 300.381627] systemd[1]: Started Nix Daemon. hub # [ 300.532728] nix-daemon[1119]: accepted connection from pid 1081, user root (trusted) worker # [ 173.243519] nix-daemon[1103]: accepted connection from pid 1096, user tribuchet (trusted) hub # [ 300.589896] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 300.592906] tailscaled[660]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 300.595456] tailscaled[660]: [RATELIMIT] format("dns udp query: %v") hub # [ 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 exceeded hub # [ 301.610825] tailscaled[660]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 301.617059] tailscaled[660]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ... worker # [ 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=false worker # [ 174.412823] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:55.423929Z INFO tribuchet::worker::agent: builder started id="32c9671be459ece7e8f25ecf1e6842a3" pid=1113 worker # [ 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/build worker # [ 174.468418] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:55.479836Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 174.626982] tribuchet[1096]: 2026-08-30T18:08:55.638231Z INFO tribuchet::worker::build::agent_exec: builder finished id="32c9671be459ece7e8f25ecf1e6842a3" exit_code=0 aborted=None worker # [ 174.643552] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1099]: 2026-08-30T18:08:55.655002Z INFO tribuchet::worker::agent: cleanup done id="32c9671be459ece7e8f25ecf1e6842a3" worker # [ 174.651542] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. worker # [ 174.660451] systemd[1]: Started tribuchet-agent@1.service. worker # [ 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=65536 worker # [ 174.691451] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.702060Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 174.695687] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.702112Z INFO tribuchet::worker::agent: agent listening uid=995 worker # [ 174.699748] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1124]: 2026-08-30T18:08:55.702173Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 174.705247] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. worker # [ 174.734640] tribuchet[1096]: 2026-08-30T18:08:55.745721Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="32c9671be459ece7e8f25ecf1e6842a3" worker # [ 174.750372] tribuchet[1096]: 2026-08-30T18:08:55.761820Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="32c9671be459ece7e8f25ecf1e6842a3" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 2.25 seconds) hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/667vxncdcca78rn0fyqbrb7rvn7aiyis-tt-tailscale hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/667vxncdcca78rn0fyqbrb7rvn7aiyis-tt-tailscale, in 0.04 seconds) hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build' hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.03 seconds) worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished' worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.02 seconds) (finished: subtest: a build dispatches over the tailnet, in 25.89 seconds) subtest: a non-tailnet peer is rejected worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.01 seconds) worker: must succeed: systemctl restart tribuchet-worker worker # [ 174.886798] systemd[1]: Stopping tribuchet-worker.service... worker # [ 174.890163] tribuchet[1096]: 2026-08-30T18:08:55.897992Z INFO tribuchet::worker: handover requested; exiting worker # [ 174.895162] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 174.898502] systemd[1]: Stopped tribuchet-worker.service. hub # [ 302.223620] tribuchet[1081]: 2026-08-30T18:08:55.355614Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 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. worker # [ 174.912425] systemd[1]: Starting tribuchet-worker.service... worker # [ 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 } worker # [ 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") worker # [ 175.074432] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.21 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' worker # [ 175.087449] systemd[1]: Started tribuchet-agent@1.service. worker # [ 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=65536 worker # [ 175.125359] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1147]: 2026-08-30T18:08:56.136263Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 175.129930] 82f1yrppraq5sqqxjqzcfqdnikmjbxak-tribuchet-agent[1147]: 2026-08-30T18:08:56.136342Z INFO tribuchet::worker::agent: agent listening uid=995 hub # [ 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:32862 worker # [ 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" worker # [ 175.516378] tribuchet[1144]: 2026-08-30T18:08:56.523031Z INFO tribuchet::worker: reconnecting to hub in 1s hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.10 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.32 seconds) (finished: run the VM test script, in 314.94 seconds) hub # [ 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:32874 worker # [ 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" worker # [ 176.886730] tribuchet[1144]: 2026-08-30T18:08:57.892810Z INFO tribuchet::worker: reconnecting to hub in 2s hub # [ 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 exceeded hub # [ 304.616231] tailscaled[660]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 304.623345] tailscaled[660]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ... hub # [ 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:32890 worker # [ 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" worker # [ 179.254755] tribuchet[1144]: 2026-08-30T18:09:00.261963Z INFO tribuchet::worker: reconnecting to hub in 4s hub # [ 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 exceeded hub # [ 307.628853] tailscaled[660]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 307.634961] tailscaled[660]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ... hub # [ 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 exceeded hub # [ 310.587145] tailscaled[660]: health: connectivity impacted; triggering captive portal detection hub # [ 310.588793] tailscaled[660]: health(warnable=dns-forward-failing): error: Tailscale can't reach the configured DNS servers. Internet connectivity may be affected. hub # [ 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 exceeded hub # [ 310.635064] tailscaled[660]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ... hub # [ 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 unreachable hub # [ 310.642180] tailscaled[660]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... hub # [ 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:57170 worker # [ 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" worker # [ 183.624771] tribuchet[1144]: 2026-08-30T18:09:04.631964Z INFO tribuchet::worker: reconnecting to hub in 8s hub # [ 312.591669] tailscaled[660]: health(warnable=dns-forward-failing): ok hub # [ 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 exceeded worker # [ 186.808631] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded worker # [ 186.813204] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 317.592100] tailscaled[660]: tailscale.com/feature/captiveportal captiveportal.go:96: subscriber for health.Change is slow (5.000062857s elapsed) hub # [ 318.593368] tailscaled[660]: DetectCaptivePortal(found=false) worker # [ 191.809437] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded worker # [ 191.813337] tailscaled[698]: dns udp query: waiting for response or error from [10.0.2.3]: context deadline exceeded hub # [ 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:57180 worker # [ 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" worker # [ 191.993359] tribuchet[1144]: 2026-08-30T18:09:13.004648Z INFO tribuchet::worker: reconnecting to hub in 16s test script finished in 332.16s cleanup kill QemuMachine (pid 47) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) kill QemuMachine (pid 48) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.45 seconds)