tribuchet: building on jamie 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 seconds run the VM test script start all VMs hub: starting vm worker: starting vm hub: QEMU running (pid 48) hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.bBFoA5OVlx', 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: 3a39aab2-8a40-480b-81b0-3a5080991b97 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 # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1920+7EF31920 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:03.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1920 7EF31920 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:09.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 0.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 UTC 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/nwvvpfqqnb1rygn0s3cqj8m6p9iaffw7-nixos-system-hub-test/init regInfo=/nix/store/qr7bgdx06zv13rbv1v68glcbrkb8qiq3-closure-info/registration console=ttyS0,115200n8 console=tty0 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-0x000000007ffdafff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] 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 (i440FX + PIIX, 1996), 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 = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000001] kvm-clock: using sched offset of 503227245 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000005] tsc: Detected 2400.018 MHz processor hub # [ 0.000824] last_pfn = 0x7ffdb max_arch_pfn = 0x10000000000 hub # [ 0.000860] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000863] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002779] found SMP MP-table at [mem 0x000f5470-0x000f547f] hub # [ 0.002790] Using GB pages for direct mapping hub # [ 0.002905] RAMDISK: [mem 0x7e302000-0x7ffcffff] hub # [ 0.002913] ACPI: Early table checksum verification disabled hub # [ 0.002916] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) hub # [ 0.002920] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002924] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002930] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002932] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002934] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002935] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002937] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002938] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] hub # [ 0.002939] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] hub # [ 0.002940] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002941] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] hub # [ 0.002941] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] hub # [ 0.002941] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] hub # [ 0.003425] No NUMA configuration found hub # [ 0.003426] Faking a node at [mem 0x0000000000000000-0x000000007ffdafff] hub # [ 0.003430] NODE_DATA(0) allocated [mem 0x7ffd5780-0x7ffdacff] hub # [ 0.005820] Zone ranges: hub # [ 0.005820] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005822] DMA32 [mem 0x0000000001000000-0x000000007ffdafff] hub # [ 0.005823] Normal empty hub # [ 0.005824] Device empty hub # [ 0.005825] Movable zone start for each node hub # [ 0.005826] Early memory node ranges hub # [ 0.005826] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005827] node 0: [mem 0x0000000000100000-0x000000007ffdafff] hub # [ 0.005828] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] hub # [ 0.005847] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.006124] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.044025] On node 0, zone DMA32: 37 pages in unavailable ranges hub # [ 0.045009] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.045024] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.045057] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.045059] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.045061] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.045062] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.045063] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.045064] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.045067] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.045068] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.045073] TSC deadline timer available hub # [ 0.045077] CPU topo: Max. logical packages: 1 hub # [ 0.045078] CPU topo: Max. logical dies: 1 hub # [ 0.045078] CPU topo: Max. dies per package: 1 hub # [ 0.045081] CPU topo: Max. threads per core: 1 hub # [ 0.045082] CPU topo: Num. cores per package: 1 hub # [ 0.045082] CPU topo: Num. threads per package: 1 hub # [ 0.045083] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.045104] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.045141] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.045142] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.045144] [mem 0x80000000-0xfeffbfff] available for PCI devices hub # [ 0.045145] Booting paravirtualized kernel on KVM hub # [ 0.045148] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.049639] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.051962] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.052008] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.052010] 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/nwvvpfqqnb1rygn0s3cqj8m6p9iaffw7-nixos-system-hub-test/init regInfo=/nix/store/qr7bgdx06zv13rbv1v68glcbrkb8qiq3-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.052104] Unknown kernel command line parameters "regInfo=/nix/store/qr7bgdx06zv13rbv1v68glcbrkb8qiq3-closure-info/registration", will be passed to user space. hub # [ 0.052116] random: crng init done hub # [ 0.052117] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.054395] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.054417] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.054449] Fallback order for Node 0: 0 hub # [ 0.054452] Built 1 zonelists, mobility grouping on. Total pages: 524153 hub # [ 0.054452] Policy zone: DMA32 hub # [ 0.057330] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.061239] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.066030] allocated 4194304 bytes of page_ext hub # [ 0.076008] ftrace: allocating 48598 entries in 192 pages hub # [ 0.076010] ftrace: allocated 192 pages with 2 groups hub # [ 0.076855] Dynamic Preempt: lazy hub # [ 0.077034] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.077035] rcu: RCU event tracing is enabled. hub # [ 0.077036] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.077037] Trampoline variant of Tasks RCU enabled. hub # [ 0.077038] Rude variant of Tasks RCU enabled. hub # [ 0.077038] Tracing variant of Tasks RCU enabled. hub # [ 0.077039] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.077039] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.077067] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077068] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077069] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.081731] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.082013] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.082120] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.089342] Console: colour VGA+ 80x25 hub # [ 0.089346] printk: legacy console [tty0] enabled hub # [ 0.129619] printk: legacy console [ttyS0] enabled hub # [ 0.312980] ACPI: Core revision 20250807 hub # [ 0.314513] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.317334] APIC: Switch to symmetric I/O mode setup hub # [ 0.319040] x2apic enabled hub # [ 0.320262] APIC: Switched APIC routing to: physical x2apic hub # [ 0.323058] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.324872] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.327928] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) hub # [ 0.330043] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.331067] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.331927] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.332929] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.334926] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.335927] Transient Scheduler Attacks: Mitigation: Clear CPU buffers hub # [ 0.337926] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.339926] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.340926] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.341932] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.342927] active return thunk: srso_alias_return_thunk hub # [ 0.343964] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.344926] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.346927] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.348926] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.349926] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.350926] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.351931] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.352926] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 0.354926] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' hub # [ 0.355927] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.357926] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.359926] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.361926] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.362926] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.363926] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 hub # [ 0.364926] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 hub # [ 0.365926] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 0.402010] Freeing SMP alternatives memory: 44K hub # [ 0.402928] pid_max: default: 32768 minimum: 301 hub # [ 0.404929] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.406030] landlock: Up and running. hub # [ 0.407925] Yama: becoming mindful. hub # [ 0.409138] LSM support for eBPF active hub # [ 0.410059] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.411987] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.415059] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.416518] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.416936] ... version: 2 hub # [ 0.417928] ... bit width: 48 hub # [ 0.418927] ... generic counters: 6 hub # [ 0.419927] ... generic bitmap: 000000000000003f hub # [ 0.420927] ... fixed-purpose counters: 0 hub # [ 0.421928] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.422928] ... value mask: 0000ffffffffffff hub # [ 0.423927] ... max period: 00007fffffffffff hub # [ 0.424927] ... global_ctrl mask: 000000000000003f hub # [ 0.426050] signal: max sigframe size: 3376 hub # [ 0.427026] rcu: Hierarchical SRCU implementation. hub # [ 0.427932] rcu: Max phase no-delay instances is 400. hub # [ 0.433538] smp: Bringing up secondary CPUs ... hub # [ 0.433944] smp: Brought up 1 node, 1 CPU hub # [ 0.434930] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) hub # [ 0.436112] Memory: 1969256K/2096612K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117940K reserved, 0K cma-reserved) hub # [ 0.437177] devtmpfs: initialized hub # [ 0.438155] x86/mm: Memory block size: 128MB hub # [ 0.440048] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.440959] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.441957] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.443016] pinctrl core: initialized pinctrl subsystem hub # [ 0.444250] PM: RTC time: 14:45:09, date: 2026-07-13 hub # [ 0.447797] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.449465] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.449955] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.451225] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.451939] audit: initializing netlink subsys (disabled) hub # [ 0.453237] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.453239] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.453931] audit: type=2000 audit(1783953909.510:1): state=initialized audit_enabled=0 res=1 hub # [ 0.455930] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.455932] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.456928] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.457948] cpuidle: using governor menu hub # [ 0.461073] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.462203] PCI: Using configuration type 1 for base access hub # [ 0.462928] PCI: Using configuration type 1 for extended access hub # [ 0.464172] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.469070] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.469928] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.474927] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.475928] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.484322] ACPI: Added _OSI(Module Device) hub # [ 0.484928] ACPI: Added _OSI(Processor Device) hub # [ 0.487937] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.494144] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.498352] ACPI: Interpreter enabled hub # [ 0.498945] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.501927] ACPI: Using IOAPIC for interrupt routing hub # [ 0.502948] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.505926] PCI: Using E820 reservations for host bridge windows hub # [ 0.507088] ACPI: Enabled 2 GPEs in block 00 to 0F hub # [ 0.517443] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.517934] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.519358] acpiphp: Slot [3] registered hub # [ 0.519971] acpiphp: Slot [4] registered hub # [ 0.520987] acpiphp: Slot [5] registered hub # [ 0.522010] acpiphp: Slot [6] registered hub # [ 0.522990] acpiphp: Slot [7] registered hub # [ 0.523968] acpiphp: Slot [8] registered hub # [ 0.524992] acpiphp: Slot [9] registered hub # [ 0.525969] acpiphp: Slot [10] registered hub # [ 0.526969] acpiphp: Slot [11] registered hub # [ 0.527990] acpiphp: Slot [12] registered hub # [ 0.528969] acpiphp: Slot [13] registered hub # [ 0.529982] acpiphp: Slot [14] registered hub # [ 0.530960] acpiphp: Slot [15] registered hub # [ 0.531979] acpiphp: Slot [16] registered hub # [ 0.532961] acpiphp: Slot [17] registered hub # [ 0.533960] acpiphp: Slot [18] registered hub # [ 0.534966] acpiphp: Slot [19] registered hub # [ 0.535974] acpiphp: Slot [20] registered hub # [ 0.536970] acpiphp: Slot [21] registered hub # [ 0.537961] acpiphp: Slot [22] registered hub # [ 0.538960] acpiphp: Slot [23] registered hub # [ 0.539974] acpiphp: Slot [24] registered hub # [ 0.540961] acpiphp: Slot [25] registered hub # [ 0.541960] acpiphp: Slot [26] registered hub # [ 0.542973] acpiphp: Slot [27] registered hub # [ 0.543961] acpiphp: Slot [28] registered hub # [ 0.544982] acpiphp: Slot [29] registered hub # [ 0.545963] acpiphp: Slot [30] registered hub # [ 0.546976] acpiphp: Slot [31] registered hub # [ 0.547958] PCI host bridge to bus 0000:00 hub # [ 0.548934] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.549929] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.550929] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.551928] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] hub # [ 0.552929] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] hub # [ 0.553929] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.555296] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.556826] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.558829] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint hub # [ 0.561606] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] hub # [ 0.561992] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk hub # [ 0.562928] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk hub # [ 0.563928] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk hub # [ 0.564928] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk hub # [ 0.566319] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.568609] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] hub # [ 0.570114] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint hub # [ 0.571574] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI hub # [ 0.572942] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB hub # [ 0.574354] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.577003] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.577958] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.578980] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.580154] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.582031] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.584965] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.585942] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.586979] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.587942] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.591062] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.593928] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.594942] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.595979] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.598966] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.600943] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.601942] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.602980] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.605996] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.608966] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.610945] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.611987] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.615052] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.617966] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.618943] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.619980] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.623360] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.625996] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.626944] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.627981] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.631420] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.633929] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.634995] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.635980] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.636942] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.639926] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.642517] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.642980] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.645928] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.648928] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.649942] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.650980] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.653941] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.655952] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.656942] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.657982] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.666383] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.667137] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.668117] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.669119] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.670039] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 hub # [ 0.672100] iommu: Default domain type: Translated hub # [ 0.672938] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.674213] ACPI: bus type USB registered hub # [ 0.674997] usbcore: registered new interface driver usbfs hub # [ 0.675965] usbcore: registered new interface driver hub hub # [ 0.676938] usbcore: registered new device driver usb hub # [ 0.678791] NetLabel: Initializing hub # [ 0.679756] NetLabel: domain hash size = 128 hub # [ 0.680928] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.681974] NetLabel: unlabeled traffic allowed by default hub # [ 0.682943] PCI: Using ACPI for IRQ routing hub # [ 0.684563] pci 0000:00:02.0: vgaarb: setting as boot VGA device hub # [ 0.684923] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 0.684923] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.684929] vgaarb: loaded hub # [ 0.686066] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.686927] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.691007] clocksource: Switched to clocksource kvm-clock hub # [ 0.695069] VFS: Disk quotas dquot_6.6.0 hub # [ 0.696312] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.698566] pnp: PnP ACPI init hub # [ 0.700242] pnp: PnP ACPI: found 6 devices hub # [ 0.708431] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.710998] clocksource: Switched to clocksource acpi_pm hub # [ 0.712673] NET: Registered PF_INET protocol family hub # [ 0.714543] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.732830] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.735500] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.737823] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.740227] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.742417] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.744412] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.746627] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.748629] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.750780] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.752527] NET: Registered PF_XDP protocol family hub # [ 0.754053] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.755857] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.757698] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.759703] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] hub # [ 0.761703] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] hub # [ 0.763836] pci 0000:00:01.0: PIIX3: Enabling Passive Release hub # [ 0.765623] pci 0000:00:00.0: Limiting direct PCI/PCI transfers hub # [ 0.769015] ACPI: \_SB_.LNKD: Enabled at IRQ 11 hub # [ 0.772339] PCI: CLS 0 bytes, default 64 hub # [ 0.773827] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 0.776845] Trying to unpack rootfs image as initramfs... hub # [ 0.823191] Initialise system trusted keyrings hub # [ 0.828005] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.851534] Key type asymmetric registered hub # [ 0.857968] Asymmetric key parser 'x509' registered hub # [ 0.859506] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.866080] io scheduler mq-deadline registered hub # [ 0.867482] io scheduler kyber registered hub # [ 0.872967] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.878237] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.885125] Linux agpgart interface v0.103 hub # [ 0.886470] ACPI: bus type drm_connector registered hub # [ 0.893137] usbcore: registered new interface driver usbserial_generic hub # [ 0.895074] usbserial: USB Serial support registered for generic hub # [ 0.899958] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.899958] Please enable it if your BIOS has the CPPC option. hub # [ 0.903847] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.911114] drop_monitor: Initializing network drop monitor service hub # [ 0.913111] NET: Registered PF_INET6 protocol family hub # [ 0.918445] Segment Routing with IPv6 hub # [ 0.922961] In-situ OAM (IOAM) with IPv6 hub # [ 0.924572] IPI shorthand broadcast: enabled hub # [ 0.933312] sched_clock: Marking stable (694028122, 238903546)->(1130368691, -197437023) hub # [ 0.942125] registered taskstats version 1 hub # [ 0.943655] Loading compiled-in X.509 certificates hub # [ 0.965961] Demotion targets for Node 0: null hub # [ 0.968996] Key type .fscrypt registered hub # [ 0.970233] Key type fscrypt-provisioning registered hub # [ 0.975062] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.976698] ima: Allocated hash algorithm: sha1 hub # [ 0.981985] ima: No architecture policies found hub # [ 0.983574] PM: Magic number: 2:703:788 hub # [ 0.987785] RAS: Correctable Errors collector initialized. hub # [ 0.997804] clk: Disabling unused clocks hub # [ 1.002951] PM: genpd: Disabling unused power domains hub # [ 1.145453] Freeing initrd memory: 29496K hub # [ 1.149375] Freeing unused decrypted memory: 2028K hub # [ 1.152799] Freeing unused kernel image (initmem) memory: 3636K hub # [ 1.154698] Write protecting the kernel read-only data: 32768k hub # [ 1.157479] Freeing unused kernel image (text/rodata gap) memory: 1272K hub # [ 1.159952] Freeing unused kernel image (rodata/data gap) memory: 796K hub # [ 1.213115] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.214982] Run /init as init process hub # [ 1.226363] systemd[1]: Inserted module 'autofs4' hub # [ 1.243358] fuse: init (API version 7.45) hub # [ 1.250984] ACPI: \_SB_.LNKC: Enabled at IRQ 10 hub # [ 1.259507] ACPI: \_SB_.LNKA: Enabled at IRQ 10 hub # [ 1.263989] ACPI: \_SB_.LNKB: Enabled at IRQ 11 hub # [ 1.303840] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.643714] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) hub # [ 1.665143] systemd[1]: Detected virtualization kvm. hub # [ 1.669113] systemd[1]: Detected architecture x86-64. hub # [ 1.673076] systemd[1]: Running in initrd. hub # [ 1.677132] systemd[1]: Initializing machine ID from random generator. hub # [ 1.682272] systemd[1]: Hostname set to . hub # [ 1.906360] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.960439] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.965571] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.967660] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.970133] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.972104] systemd[1]: Reached target Path Units. hub # [ 1.973647] systemd[1]: Reached target Slice Units. hub # [ 1.975325] systemd[1]: Reached target Swaps. hub # [ 1.976774] systemd[1]: Reached target Timer Units. hub # [ 1.978524] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.980645] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.982676] systemd[1]: Listening on Journal Sockets. hub # [ 1.984451] systemd[1]: Listening on udev Control Socket. hub # [ 1.986285] systemd[1]: Listening on udev Kernel Socket. hub # [ 1.988010] systemd[1]: Reached target Socket Units. hub # [ 1.990691] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 1.997064] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 2.007636] systemd[1]: Starting Load Kernel Module configfs... hub # [ 2.020173] systemd[1]: Starting Journal Service... hub # [ 2.037022] systemd[1]: Starting Load Kernel Modules... hub # [ 2.042081] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 2.060264] netfs: FS-Cache loaded hub # [ 2.066155] 9pnet: Installing 9P2000 support hub # [ 2.082240] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.093755] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.101059] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.111603] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.124037] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.129838] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.136469] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.144008] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.148078] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.153678] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.173169] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.195028] systemd[1]: Finished Load Kernel Modules. hub # [ 2.208150] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.224595] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.240257] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.257120] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.278828] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.285296] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.292043] systemd[1]: Reached target Local File Systems. hub # [ 2.301265] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.066253] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.068546] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.070523] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.320151] systemd[1]: Started Journal Service. hub # [ 2.104106] systemd[1]: Starting Create System Files and Directories... hub # [ 2.136363] systemd-udevd[75]: Using default interface naming scheme 'v261'. hub # [ 2.139108] systemd[1]: Finished Create System Files and Directories. hub # [ 2.173794] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.229158] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.230713] systemd[1]: Reached target System Initialization. hub # [ 2.232275] systemd[1]: Reached target Basic System. hub # [ 2.756547] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.786116] uhci_hcd 0000:00:01.2: UHCI Host Controller worker: QEMU running (pid 47) worker # Disk image does not exist, creating the virtualisation disk image... hub # [ 2.791000] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # Formatting '/build/vm-state-worker/tmp.YwbDjiUnVJ', fmt=raw size=1073741824 (finished: start all VMs, in 3.69 seconds) worker # mke2fs 1.47.4 (6-Mar-2025) hub # [ 2.797333] virtio_blk virtio5: 1/0/0 default/read/poll queues hub: waiting for unit headscale worker # Discarding device blocks: 0/262144 done hub: waiting for the VM to finish booting worker # Creating filesystem with 262144 4k blocks and 65536 inodes worker # Filesystem UUID: 93f734dc-3715-41a6-9914-1fcb56e2267c 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. hub # [ 2.814353] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.816297] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 hub # [ 2.832278] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 2.834875] uhci_hcd 0000:00:01.2: detected 2 ports hub # [ 2.840726] SCSI subsystem initialized hub # [ 2.845086] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 hub # [ 2.862204] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.864150] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.898063] usb usb1: Product: UHCI Host Controller hub # [ 2.666252] systemd[1]: Starting Virtual Console Setup... worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # [ 2.672208] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.918484] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd hub # [ 2.919838] usb usb1: SerialNumber: 0000:00:01.2 hub # [ 2.925722] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.696515] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.701800] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.719745] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.724912] systemd[1]: Finished Virtual Console Setup. hub # [ 2.972206] hub 1-0:1.0: USB hub found hub # [ 2.979302] hub 1-0:1.0: 2 ports detected worker # worker # worker # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+7EFD1900+7EF31900 CA00 hub # [ 2.761164] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.764096] systemd[1]: Reached target Initrd Root Device. worker # Press Ctrl-B to configure iPXE (PCI 00:03.0)... hub # [ 2.767099] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 7EFD1900 7EF31900 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:09.0)... worker # worker # hub # [ 3.032021] scsi host0: ata_piix hub # [ 3.037372] scsi host1: ata_piix hub # [ 3.042093] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 hub # [ 3.044076] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 hub # [ 2.807531] systemd-fsck[115]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.812954] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # Booting from ROM... worker # Probing EDD (edd=off to disable)... ok hub # [ 2.859048] systemd[1]: Mounting /sysroot... hub # [ 3.202595] usb 1-1: new full-speed USB device number 2 using uhci_hcd hub # [ 3.206527] ata2: found unknown device (class 0) hub # [ 3.212389] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 3.220514] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 3.303227] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 3.322334] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 3.344227] EXT4-fs (vda): mounted filesystem 3a39aab2-8a40-480b-81b0-3a5080991b97 r/w with ordered data mode. Quota mode: none. hub # [ 3.111483] systemd[1]: Mounted /sysroot. hub # [ 3.115155] systemd[1]: Reached target Initrd Root File System. hub # [ 3.120757] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 3.125101] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.131205] systemd[1]: Mounting /sysroot/run... hub # [ 3.137267] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 3.377661] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 3.379614] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 3.385935] usb 1-1: Product: QEMU USB Tablet hub # [ 3.387919] usb 1-1: Manufacturer: QEMU hub # [ 3.150577] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 3.391634] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 hub # [ 3.167905] systemd[1]: Starting Mountpoints Configured in the Real Root... worker # [ 0.000000] Linux version 6.18.38 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Jul 4 11:44:22 UTC 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/z7h3cvmg748szvj9513xr8rs0k148f0x-nixos-system-worker-test/init regInfo=/nix/store/12wj878hlymx7p60ycq1md6r2f1bg39q-closure-info/registration console=ttyS0,115200n8 console=tty0 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-0x000000007ffd7fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] 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. hub # [ 3.447752] hid: raw HID events driver (C) Jiri Kosina worker # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), 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 hub # [ 3.212241] systemd-sysroot-fstab-check[133]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000001] kvm-clock: using sched offset of 507880191 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000005] tsc: Detected 2400.018 MHz processor hub # [ 3.459295] 9p: Installing v9fs 9p2000 file system support worker # [ 0.000804] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 worker # [ 0.000840] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000843] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.002746] found SMP MP-table at [mem 0x000f5470-0x000f547f] worker # [ 0.002757] Using GB pages for direct mapping worker # [ 0.002877] RAMDISK: [mem 0x7e2fa000-0x7ffcffff] worker # [ 0.002886] ACPI: Early table checksum verification disabled worker # [ 0.002889] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) worker # [ 0.002892] ACPI: RSDT 0x000000007FFE23CC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002896] ACPI: FACP 0x000000007FFE2280 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002903] ACPI: DSDT 0x000000007FFE0040 002240 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002905] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002906] ACPI: APIC 0x000000007FFE22F4 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 3.479461] usbcore: registered new interface driver usbhid worker # [ 0.002908] ACPI: HPET 0x000000007FFE236C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002909] ACPI: WAET 0x000000007FFE23A4 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002911] ACPI: Reserving FACP table memory at [mem 0x7ffe2280-0x7ffe22f3] worker # [ 0.002912] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe227f] hub # [ 3.248051] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 0.002912] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002913] ACPI: Reserving APIC table memory at [mem 0x7ffe22f4-0x7ffe236b] hub # [ 3.490538] usbhid: USB HID core driver worker # [ 0.002913] ACPI: Reserving HPET table memory at [mem 0x7ffe236c-0x7ffe23a3] worker # [ 0.002914] ACPI: Reserving WAET table memory at [mem 0x7ffe23a4-0x7ffe23cb] hub # [ 3.254226] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 0.003404] No NUMA configuration found hub # [ 3.255737] systemd[1]: Mounted /sysroot/run. worker # [ 0.003405] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] worker # [ 0.003409] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] hub # [ 3.257571] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 0.005804] Zone ranges: worker # [ 0.005805] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 3.260603] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 0.005807] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] worker # [ 0.005808] Normal empty worker # [ 0.005809] Device empty worker # [ 0.005809] Movable zone start for each node worker # [ 0.005810] Early memory node ranges worker # [ 0.005810] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005811] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] worker # [ 0.005812] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] worker # [ 0.005833] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.006114] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 3.509662] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 0.042166] On node 0, zone DMA32: 40 pages in unavailable ranges worker # [ 0.043143] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.043158] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 3.276221] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.043191] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.043194] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 3.278088] systemd[1]: Reload requested from client PID 133 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 0.043195] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 3.281094] systemd[1]: Reloading... worker # [ 0.043196] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.043197] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.043198] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.043200] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.043201] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.043207] TSC deadline timer available worker # [ 0.043211] CPU topo: Max. logical packages: 1 hub # [ 3.526919] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 worker # [ 0.043212] CPU topo: Max. logical dies: 1 worker # [ 0.043212] CPU topo: Max. dies per package: 1 worker # [ 0.043215] CPU topo: Max. threads per core: 1 worker # [ 0.043216] CPU topo: Num. cores per package: 1 worker # [ 0.043216] CPU topo: Num. threads per package: 1 worker # [ 0.043217] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.043237] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.043273] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.043274] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.043276] [mem 0x80000000-0xfeffbfff] available for PCI devices worker # [ 0.043277] Booting paravirtualized kernel on KVM worker # [ 0.043281] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.047735] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.049947] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.049992] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.049994] 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/z7h3cvmg748szvj9513xr8rs0k148f0x-nixos-system-worker-test/init regInfo=/nix/store/12wj878hlymx7p60ycq1md6r2f1bg39q-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.050087] Unknown kernel command line parameters "regInfo=/nix/store/12wj878hlymx7p60ycq1md6r2f1bg39q-closure-info/registration", will be passed to user space. worker # [ 0.050099] random: crng init done worker # [ 0.050100] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.052280] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.052302] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.052335] Fallback order for Node 0: 0 worker # [ 0.052338] Built 1 zonelists, mobility grouping on. Total pages: 524150 worker # [ 0.052339] Policy zone: DMA32 worker # [ 0.055040] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.058588] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.063072] allocated 4194304 bytes of page_ext worker # [ 0.072928] ftrace: allocating 48598 entries in 192 pages worker # [ 0.072930] ftrace: allocated 192 pages with 2 groups worker # [ 0.073778] Dynamic Preempt: lazy worker # [ 0.073942] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.073943] rcu: RCU event tracing is enabled. worker # [ 0.073943] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.073945] Trampoline variant of Tasks RCU enabled. worker # [ 0.073945] Rude variant of Tasks RCU enabled. worker # [ 0.073945] Tracing variant of Tasks RCU enabled. worker # [ 0.073946] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.073947] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.073969] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.073971] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.073971] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.078524] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.078810] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.078909] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.086053] Console: colour VGA+ 80x25 worker # [ 0.086057] printk: legacy console [tty0] enabled worker # [ 0.126596] printk: legacy console [ttyS0] enabled worker # [ 0.309987] ACPI: Core revision 20250807 worker # [ 0.311519] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.314239] APIC: Switch to symmetric I/O mode setup worker # [ 0.315979] x2apic enabled worker # [ 0.317195] APIC: Switched APIC routing to: physical x2apic worker # [ 0.320009] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.321803] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns worker # [ 0.324849] Calibrating delay loop (skipped) preset value.. 4800.03 BogoMIPS (lpj=2400018) worker # [ 0.326966] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.327994] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.328849] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.329853] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.331848] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.332849] Transient Scheduler Attacks: Mitigation: Clear CPU buffers worker # [ 0.333848] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 3.397336] systemd[1]: Reloading finished in 114 ms. worker # [ 0.334848] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.335848] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.336854] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.338848] active return thunk: srso_alias_return_thunk worker # [ 0.339876] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.341848] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 3.409322] systemd-sysroot-fstab-check[133]: Requesting initrd-fs.target/start/replace... hub # [ 3.413812] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.342848] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 3.415856] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.344848] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.345848] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.346848] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 3.421142] systemd-sysroot-fstab-check[133]: Requesting swap.target/start/replace... worker # [ 0.347848] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.348848] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' hub # [ 3.425802] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 0.349848] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' hub # [ 3.428261] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 0.351848] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.352848] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 3.432170] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 0.354848] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 3.434257] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 0.356848] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.357848] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.358848] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 worker # [ 0.359848] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 worker # [ 0.361848] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. hub # [ 3.447365] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.449915] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.397428] Freeing SMP alternatives memory: 44K worker # [ 0.397850] pid_max: default: 32768 minimum: 301 worker # [ 0.398958] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.399968] landlock: Up and running. worker # [ 0.400848] Yama: becoming mindful. worker # [ 0.402063] LSM support for eBPF active worker # [ 0.403964] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.404890] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.407636] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.408446] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.408853] ... version: 2 worker # [ 0.409850] ... bit width: 48 worker # [ 0.410863] ... generic counters: 6 worker # [ 0.411850] ... generic bitmap: 000000000000003f worker # [ 0.412850] ... fixed-purpose counters: 0 worker # [ 0.413850] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.414850] ... value mask: 0000ffffffffffff worker # [ 0.415850] ... max period: 00007fffffffffff worker # [ 0.416850] ... global_ctrl mask: 000000000000003f worker # [ 0.417966] signal: max sigframe size: 3376 worker # [ 0.418976] rcu: Hierarchical SRCU implementation. worker # [ 0.419855] rcu: Max phase no-delay instances is 400. worker # [ 0.425368] smp: Bringing up secondary CPUs ... worker # [ 0.425866] smp: Brought up 1 node, 1 CPU worker # [ 0.426853] smpboot: Total of 1 processors activated (4800.03 BogoMIPS) worker # [ 0.428005] Memory: 1969232K/2096600K available (17159K kernel code, 2721K rwdata, 13540K rodata, 3636K init, 3020K bss, 117972K reserved, 0K cma-reserved) worker # [ 0.429097] devtmpfs: initialized worker # [ 0.430073] x86/mm: Memory block size: 128MB worker # [ 0.431973] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.432883] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.433884] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.434945] pinctrl core: initialized pinctrl subsystem worker # [ 0.436205] PM: RTC time: 14:45:13, date: 2026-07-13 worker # [ 0.439636] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.441354] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.441877] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.443129] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.443861] audit: initializing netlink subsys (disabled) worker # [ 0.445155] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.445157] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.445853] audit: type=2000 audit(1783953912.993:1): state=initialized audit_enabled=0 res=1 worker # [ 0.447853] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.447855] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.448850] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.449870] cpuidle: using governor menu worker # [ 0.453004] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.454138] PCI: Using configuration type 1 for base access worker # [ 0.454850] PCI: Using configuration type 1 for extended access worker # [ 0.456066] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.463132] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.463851] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.468850] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.469851] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.478467] ACPI: Added _OSI(Module Device) worker # [ 0.478850] ACPI: Added _OSI(Processor Device) worker # [ 0.479851] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.485676] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.491753] ACPI: Interpreter enabled worker # [ 0.492753] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.497850] ACPI: Using IOAPIC for interrupt routing worker # [ 0.498872] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.501849] PCI: Using E820 reservations for host bridge windows worker # [ 0.502999] ACPI: Enabled 2 GPEs in block 00 to 0F worker # [ 0.509768] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.510856] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.512246] acpiphp: Slot [3] registered worker # [ 0.512893] acpiphp: Slot [4] registered worker # [ 0.513903] acpiphp: Slot [5] registered worker # [ 0.514891] acpiphp: Slot [6] registered worker # [ 0.515890] acpiphp: Slot [7] registered worker # [ 0.516891] acpiphp: Slot [8] registered worker # [ 0.517912] acpiphp: Slot [9] registered worker # [ 0.518890] acpiphp: Slot [10] registered worker # [ 0.519934] acpiphp: Slot [11] registered worker # [ 0.520907] acpiphp: Slot [12] registered worker # [ 0.521891] acpiphp: Slot [13] registered worker # [ 0.522882] acpiphp: Slot [14] registered worker # [ 0.523883] acpiphp: Slot [15] registered worker # [ 0.524897] acpiphp: Slot [16] registered worker # [ 0.525883] acpiphp: Slot [17] registered worker # [ 0.526883] acpiphp: Slot [18] registered worker # [ 0.527883] acpiphp: Slot [19] registered worker # [ 0.528897] acpiphp: Slot [20] registered worker # [ 0.529883] acpiphp: Slot [21] registered worker # [ 0.530883] acpiphp: Slot [22] registered worker # [ 0.531883] acpiphp: Slot [23] registered worker # [ 0.532899] acpiphp: Slot [24] registered worker # [ 0.533893] acpiphp: Slot [25] registered worker # [ 0.534883] acpiphp: Slot [26] registered worker # [ 0.535903] acpiphp: Slot [27] registered worker # [ 0.536884] acpiphp: Slot [28] registered worker # [ 0.537903] acpiphp: Slot [29] registered worker # [ 0.538896] acpiphp: Slot [30] registered worker # [ 0.539902] acpiphp: Slot [31] registered worker # [ 0.540882] PCI host bridge to bus 0000:00 worker # [ 0.541857] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.542851] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.543851] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.544852] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] worker # [ 0.545851] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] worker # [ 0.546852] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.548162] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.549766] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.551763] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint worker # [ 0.554466] pci 0000:00:01.1: BAR 4 [io 0xc220-0xc22f] worker # [ 0.554915] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk worker # [ 0.555851] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk worker # [ 0.556851] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk worker # [ 0.557850] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk worker # [ 0.559322] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.560930] pci 0000:00:01.2: BAR 4 [io 0xc140-0xc15f] worker # [ 0.563100] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint worker # [ 0.564498] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI worker # [ 0.565865] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB worker # [ 0.567305] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.569926] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.570880] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.571903] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.573081] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.574894] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.577888] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] worker # [ 0.578865] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.579902] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.580865] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.583984] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.586685] pci 0000:00:04.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.587864] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.588902] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.591837] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.593889] pci 0000:00:05.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.594865] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.595902] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.598841] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.601502] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.602865] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.603902] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.606851] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.609884] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.610864] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.611903] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.614851] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.617830] pci 0000:00:08.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.618865] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.619902] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.623475] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.625879] pci 0000:00:09.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.626865] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.627903] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.628865] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.631876] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.633899] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.635063] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] worker # [ 0.637818] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 3.861633] systemd[1]: Mounting /sysroot/nix/store... worker # [ 0.640570] pci 0000:00:0b.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.641864] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.642902] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.645889] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.647865] pci 0000:00:0c.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.648865] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.649902] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.658039] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.659049] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.660043] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.661041] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.661955] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 worker # [ 0.664044] iommu: Default domain type: Translated worker # [ 0.664869] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.666134] ACPI: bus type USB registered worker # [ 0.666906] usbcore: registered new interface driver usbfs worker # [ 0.667888] usbcore: registered new interface driver hub worker # [ 0.668861] usbcore: registered new device driver usb worker # [ 0.670726] NetLabel: Initializing worker # [ 0.671682] NetLabel: domain hash size = 128 hub # [ 3.911570] systemd[1]: Mounted /sysroot/nix/store. worker # [ 0.672850] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 3.913764] systemd[1]: Reached target Initrd File Systems. worker # [ 0.673897] NetLabel: unlabeled traffic allowed by default worker # [ 0.674865] PCI: Using ACPI for IRQ routing hub # [ 3.916563] systemd[1]: Starting Find NixOS closure... worker # [ 0.676516] pci 0000:00:02.0: vgaarb: setting as boot VGA device worker # [ 0.676845] pci 0000:00:02.0: vgaarb: bridge control possible hub # [ 3.919783] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 0.676845] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.676852] vgaarb: loaded worker # [ 0.677989] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.678850] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.684945] clocksource: Switched to clocksource kvm-clock worker # [ 0.689097] VFS: Disk quotas dquot_6.6.0 worker # [ 0.690372] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.692601] pnp: PnP ACPI init worker # [ 0.694287] pnp: PnP ACPI: found 6 devices hub # [ 3.942398] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 3.945646] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 0.702533] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.705094] clocksource: Switched to clocksource acpi_pm worker # [ 0.706825] NET: Registered PF_INET protocol family hub # [ 3.957125] systemd[1]: Finished Find NixOS closure. worker # [ 0.708694] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 3.958509] systemd[1]: Reached target Initrd Default Target. hub # [ 3.961118] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 0.726759] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 3.976339] systemd[1]: Stopped target Initrd Default Target. hub # [ 3.978236] systemd[1]: Stopped target Basic System. worker # [ 0.729461] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.731745] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 3.981098] systemd[1]: Stopped target Initrd Root Device. hub # [ 3.982553] systemd[1]: Stopped target Path Units. worker # [ 0.734143] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 3.984128] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 0.736331] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 3.986002] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 0.738311] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 3.987924] systemd[1]: Stopped target Slice Units. worker # [ 0.740521] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 3.989602] systemd[1]: Stopped target Socket Units. worker # [ 0.742485] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 3.991523] systemd[1]: Stopped target System Initialization. worker # [ 0.744615] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 3.993456] systemd[1]: Stopped target Swaps. worker # [ 0.746349] NET: Registered PF_XDP protocol family hub # [ 3.995304] systemd[1]: Stopped target Timer Units. worker # [ 0.747848] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 3.997219] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 0.749697] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 3.998779] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 0.751526] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 4.000565] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 0.753517] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] hub # [ 4.002820] systemd[1]: Stopped Find NixOS closure. worker # [ 0.755509] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] worker # [ 0.757636] pci 0000:00:01.0: PIIX3: Enabling Passive Release hub # [ 4.005225] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 0.759390] pci 0000:00:00.0: Limiting direct PCI/PCI transfers hub # [ 4.007914] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.009472] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 0.762639] ACPI: \_SB_.LNKD: Enabled at IRQ 11 hub # [ 4.012385] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.013817] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 0.766325] PCI: CLS 0 bytes, default 64 hub # [ 4.015660] systemd[1]: Stopped Load Kernel Modules. worker # [ 0.767822] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229848b50c4, max_idle_ns: 440795322125 ns hub # [ 4.018225] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 0.770817] Trying to unpack rootfs image as initramfs... hub # [ 4.020231] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.022224] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.024090] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.026352] systemd[1]: Stopped target Local File Systems. hub # [ 4.028373] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.030431] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 4.033223] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 4.036215] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.040243] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 4.042192] systemd[1]: Stopped Virtual Console Setup. hub # [ 4.052906] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.058914] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 4.063531] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 0.818508] Initialise system trusted keyrings hub # [ 4.066971] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 0.820128] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 4.069316] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.072101] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 4.076125] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 4.077977] systemd[1]: Closed udev Control Socket. hub # [ 4.081046] systemd[1]: Starting Cleanup udev Database... hub # [ 4.082600] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.084567] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.086260] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.089239] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.091124] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.092900] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 0.845442] Key type asymmetric registered worker # [ 0.846752] Asymmetric key parser 'x509' registered worker # [ 0.851154] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.857139] io scheduler mq-deadline registered worker # [ 0.860083] io scheduler kyber registered hub # [ 4.109202] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.112169] systemd[1]: Finished Cleanup udev Database. worker # [ 0.863636] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 4.114357] systemd[1]: Reached target Switch Root. worker # [ 0.865860] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 4.116789] systemd[1]: Starting NixOS Activation... worker # [ 0.874640] Linux agpgart interface v0.103 worker # [ 0.876009] ACPI: bus type drm_connector registered worker # [ 0.881285] usbcore: registered new interface driver usbserial_generic worker # [ 0.883212] usbserial: USB Serial support registered for generic worker # [ 0.889085] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. worker # [ 0.889085] Please enable it if your BIOS has the CPPC option. worker # [ 0.893016] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.900225] drop_monitor: Initializing network drop monitor service worker # [ 0.904254] NET: Registered PF_INET6 protocol family worker # [ 0.909375] Segment Routing with IPv6 worker # [ 0.913098] In-situ OAM (IOAM) with IPv6 worker # [ 0.914730] IPI shorthand broadcast: enabled worker # [ 0.923470] sched_clock: Marking stable (684029995, 239029255)->(1116168998, -193109748) worker # [ 0.932179] registered taskstats version 1 worker # [ 0.933705] Loading compiled-in X.509 certificates worker # [ 0.954080] Demotion targets for Node 0: null worker # [ 0.957137] Key type .fscrypt registered worker # [ 0.960078] Key type fscrypt-provisioning registered worker # [ 0.961743] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.968075] ima: Allocated hash algorithm: sha1 worker # [ 0.969552] ima: No architecture policies found worker # [ 0.974093] PM: Magic number: 2:703:788 worker # [ 0.978343] RAS: Correctable Errors collector initialized. worker # [ 0.987829] clk: Disabling unused clocks worker # [ 0.991079] PM: genpd: Disabling unused power domains hub # [ 4.290537] initrd-nixos-activation-start[183]: booting system configuration /nix/store/nwvvpfqqnb1rygn0s3cqj8m6p9iaffw7-nixos-system-hub-test hub # [ 4.361516] initrd-nixos-activation-start[183]: running activation script... worker # [ 1.135866] Freeing initrd memory: 29528K worker # [ 1.139790] Freeing unused decrypted memory: 2028K worker # [ 1.143260] Freeing unused kernel image (initmem) memory: 3636K worker # [ 1.145153] Write protecting the kernel read-only data: 32768k worker # [ 1.147885] Freeing unused kernel image (text/rodata gap) memory: 1272K worker # [ 1.150394] Freeing unused kernel image (rodata/data gap) memory: 796K worker # [ 1.203408] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.205376] Run /init as init process worker # [ 1.216657] systemd[1]: Inserted module 'autofs4' worker # [ 1.233580] fuse: init (API version 7.45) worker # [ 1.241075] ACPI: \_SB_.LNKC: Enabled at IRQ 10 worker # [ 1.249878] ACPI: \_SB_.LNKA: Enabled at IRQ 10 worker # [ 1.254430] ACPI: \_SB_.LNKB: Enabled at IRQ 11 worker # [ 1.294021] systemd[1]: Successfully made /usr/ read-only. hub # [ 4.817900] initrd-nixos-activation-start[206]: setting up /etc... worker # [ 1.633841] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) worker # [ 1.655214] systemd[1]: Detected virtualization kvm. worker # [ 1.659005] systemd[1]: Detected architecture x86-64. worker # [ 1.663167] systemd[1]: Running in initrd. worker # [ 1.667312] systemd[1]: Initializing machine ID from random generator. worker # [ 1.672463] systemd[1]: Hostname set to . hub # [ 5.118295] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.120446] systemd[1]: Finished NixOS Activation. hub # [ 5.123363] systemd[1]: Starting Switch Root... hub # [ 5.138318] systemd[1]: Switching root. worker # [ 1.894680] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 1.955258] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 1.960702] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.962807] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.965317] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.967353] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.969323] systemd[1]: Reached target Path Units. worker # [ 1.970876] systemd[1]: Reached target Slice Units. worker # [ 1.972503] systemd[1]: Reached target Swaps. worker # [ 1.973950] systemd[1]: Reached target Timer Units. worker # [ 1.975726] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 1.977912] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 1.979943] systemd[1]: Listening on Journal Sockets. worker # [ 1.981712] systemd[1]: Listening on udev Control Socket. worker # [ 1.983569] systemd[1]: Listening on udev Kernel Socket. worker # [ 1.985292] systemd[1]: Reached target Socket Units. worker # [ 1.988005] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 1.994208] systemd[1]: Starting Load Kernel Module 9pnet_virtio... worker # [ 2.004853] systemd[1]: Starting Load Kernel Module configfs... worker # [ 2.017810] systemd[1]: Starting Journal Service... hub # [ 5.508031] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 2.034147] systemd[1]: Starting Load Kernel Modules... worker # [ 2.040201] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 2.057918] netfs: FS-Cache loaded worker # [ 2.063727] 9pnet: Installing 9P2000 support worker # [ 2.078361] systemd[1]: Starting Coldplug All udev Devices... worker # [ 2.090772] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 2.099194] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 2.108917] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 2.122188] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 2.131525] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 2.133624] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 2.142120] systemd[1]: Finished Load Kernel Module configfs. worker # [ 2.146083] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 2.151799] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 2.172302] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 5.670495] NET: Registered PF_VSOCK protocol family worker # [ 2.191575] systemd[1]: Finished Load Kernel Modules. worker # [ 2.204169] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.221587] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.235405] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.254396] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.277234] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 2.282417] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 2.290168] systemd[1]: Reached target Local File Systems. worker # [ 2.298355] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 2.063763] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 2.066934] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 2.069474] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 2.317290] systemd[1]: Started Journal Service. worker # [ 2.102317] systemd[1]: Starting Create System Files and Directories... worker # [ 2.133944] systemd-udevd[74]: Using default interface naming scheme 'v261'. worker # [ 2.140130] systemd[1]: Finished Create System Files and Directories. worker # [ 2.173145] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 2.222205] systemd[1]: Finished Coldplug All udev Devices. worker # [ 2.223770] systemd[1]: Reached target System Initialization. worker # [ 2.225355] systemd[1]: Reached target Basic System. hub # [ 6.058848] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) hub # [ 6.075005] systemd[1]: Detected virtualization kvm. hub # [ 6.078091] systemd[1]: Detected architecture x86-64. hub # [ 6.081244] systemd[1]: Detected first boot. hub # [ 6.088444] systemd[1]: Initializing machine ID from random generator. hub # [ 6.223038] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 2.747664] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 worker # [ 2.788422] virtio_blk virtio4: 1/0/0 default/read/poll queues worker # [ 2.793291] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.796280] uhci_hcd 0000:00:01.2: UHCI Host Controller worker # [ 2.817478] serio: i8042 AUX port at 0x60,0x64 irq 12 worker # [ 2.820394] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 worker # [ 2.824913] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) worker # [ 2.837627] uhci_hcd 0000:00:01.2: detected 2 ports worker # [ 2.839750] SCSI subsystem initialized worker # [ 2.845193] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c140 hub # [ 6.345244] systemd[1]: Applying preset policy. worker # [ 2.859493] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.862866] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.876343] virtio_blk virtio5: [vdb] 2081968 512-byte logical blocks (1.07 GB/1017 MiB) worker # [ 2.881884] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.903074] usb usb1: Product: UHCI Host Controller worker # [ 2.665958] systemd[1]: Starting Virtual Console Setup... worker # [ 2.669172] (udev-worker)[87]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.680650] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.689946] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.936071] usb usb1: Manufacturer: Linux 6.18.38 uhci_hcd worker # [ 2.948140] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.713939] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.720682] systemd[1]: Finished Virtual Console Setup. worker # [ 2.963536] usb usb1: SerialNumber: 0000:00:01.2 worker # [ 2.976737] hub 1-0:1.0: USB hub found worker # [ 2.989052] hub 1-0:1.0: 2 ports detected worker # [ 2.782352] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.791433] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.795063] systemd[1]: Reached target Initrd Root Device. worker # [ 2.797345] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 3.040205] scsi host0: ata_piix worker # [ 3.049333] scsi host1: ata_piix worker # [ 3.050325] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc220 irq 14 lpm-pol 0 worker # [ 3.057135] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc228 irq 15 lpm-pol 0 worker # [ 2.830123] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.837444] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.857919] systemd[1]: Mounting /sysroot... worker # [ 3.214735] ata2: found unknown device (class 0) worker # [ 3.217724] usb 1-1: new full-speed USB device number 2 using uhci_hcd worker # [ 3.225318] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.232912] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 3.309394] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.330475] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.353396] EXT4-fs (vda): mounted filesystem 93f734dc-3715-41a6-9914-1fcb56e2267c r/w with ordered data mode. Quota mode: none. worker # [ 3.119917] systemd[1]: Mounted /sysroot. worker # [ 3.122853] systemd[1]: Reached target Initrd Root File System. worker # [ 3.127352] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 3.133211] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.140095] systemd[1]: Mounting /sysroot/run... worker # [ 3.151400] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.393898] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 3.395837] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 3.402069] usb 1-1: Product: QEMU USB Tablet worker # [ 3.164497] systemd[1]: Mounting /sysroot/tmp/xchg... worker # [ 3.405110] usb 1-1: Manufacturer: QEMU worker # [ 3.408049] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 worker # [ 3.175203] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 6.901508] systemd[1]: Populated /etc with preset unit settings. worker # [ 3.462232] hid: raw HID events driver (C) Jiri Kosina worker # [ 3.228816] systemd-sysroot-fstab-check[135]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.234100] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.475747] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 3.492190] usbcore: registered new interface driver usbhid worker # [ 3.498981] 9p: Installing v9fs 9p2000 file system support worker # [ 3.503638] usbhid: USB HID core driver worker # [ 3.266805] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.271152] systemd[1]: Mounted /sysroot/run. worker # [ 3.286488] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.287927] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.531754] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 3.298109] systemd[1]: Reload requested from client PID 135 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.300821] systemd[1]: Reloading... worker # [ 3.550764] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 worker # [ 3.408602] systemd[1]: Reloading finished in 111 ms. worker # [ 3.419721] systemd-sysroot-fstab-check[135]: Requesting initrd-fs.target/start/replace... worker # [ 3.426402] systemd-sysroot-fstab-check[135]: Requesting swap.target/start/replace... worker # [ 3.429667] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.432196] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.435100] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.439142] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.451542] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.454194] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 7.469361] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 7.471773] systemd[1]: Stopped initrd-switch-root.service. hub # [ 7.475599] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. hub # [ 7.478763] systemd[1]: Created slice Slice /system/getty. hub # [ 7.480813] systemd[1]: Created slice User and Session Slice. hub # [ 7.482471] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 7.484510] systemd[1]: Started Forward Password Requests to Wall Directory Watch. hub # [ 7.486377] systemd[1]: Expecting device /dev/hvc0... hub # [ 7.487630] systemd[1]: Expecting device /dev/ttyS0... hub # [ 7.489014] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 7.490472] systemd[1]: Stopped target initrd-fs.target. hub # [ 7.491795] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 7.493219] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 7.494719] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 7.496350] systemd[1]: Reached target Path Units. hub # [ 7.497620] systemd[1]: Reached target Remote File Systems. hub # [ 7.499034] systemd[1]: Reached target Slice Units. hub # [ 7.500300] systemd[1]: Reached target Swaps. hub # [ 7.504534] systemd[1]: Listening on Query the User Interactively for a Password. hub # [ 7.509483] systemd[1]: Listening on Process Core Dump Socket. hub # [ 7.513249] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 7.517027] systemd[1]: Listening on Factory Reset Management. hub # [ 7.518593] systemd[1]: Listening on Hostname Service Socket. hub # [ 7.523332] systemd[1]: Starting Journal Log Access Socket... hub # [ 7.525706] systemd[1]: Listening on Journal Audit Socket. hub # [ 7.529707] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 7.532062] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. hub # [ 7.534261] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.536433] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 7.548081] systemd[1]: Listening on Disk Repartitioning Service Socket. hub # [ 7.549887] systemd[1]: Listening on udev Control Socket. hub # [ 7.551406] systemd[1]: Listening on udev Varlink Socket. hub # [ 7.556188] systemd[1]: Mounting Huge Pages File System... hub # [ 7.560379] systemd[1]: Mounting POSIX Message Queue File System... hub # [ 7.568046] systemd[1]: Mounting Kernel Debug File System... hub # [ 7.575720] systemd[1]: Mounting Kernel Trace File System... hub # [ 7.583668] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 3.860618] systemd[1]: Mounting /sysroot/nix/store... hub # [ 7.587911] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 7.599826] systemd[1]: Starting Load Kernel Module configfs... hub # [ 7.602181] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 7.604602] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 7.608479] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 7.618215] systemd[1]: Mounting FUSE Control File System... hub # [ 7.620507] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 3.912483] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.915107] systemd[1]: Reached target Initrd File Systems. worker # [ 3.917394] systemd[1]: Starting Find NixOS closure... worker # [ 3.921069] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 7.650480] systemd[1]: Starting Journal Service... worker # [ 3.943247] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 7.671500] systemd[1]: Starting Load Kernel Modules... worker # [ 3.947878] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 3.956359] systemd[1]: Finished Find NixOS closure. worker # [ 3.958655] systemd[1]: Reached target Initrd Default Target. hub # [ 7.685180] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 3.961406] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 7.694086] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 3.978118] systemd[1]: Stopped target Initrd Default Target. worker # [ 3.980119] systemd[1]: Stopped target Basic System. hub # [ 7.705450] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 3.982104] systemd[1]: Stopped target Initrd Root Device. worker # [ 3.983666] systemd[1]: Stopped target Path Units. worker # [ 3.985319] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 3.987932] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 3.990310] systemd[1]: Stopped target Slice Units. worker # [ 3.992166] systemd[1]: Stopped target Socket Units. worker # [ 3.993550] systemd[1]: Stopped target System Initialization. worker # [ 3.996252] systemd[1]: Stopped target Swaps. hub # [ 7.722390] systemd[1]: Starting Coldplug All udev Devices... worker # [ 3.997503] systemd[1]: Stopped target Timer Units. worker # [ 3.999199] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.001221] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 4.003197] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 4.006196] systemd[1]: Stopped Find NixOS closure. worker # [ 4.007541] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 4.010279] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 4.012148] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 7.738669] systemd-journald[276]: Collecting audit messages is enabled. worker # [ 4.014208] systemd[1]: Stopped Apply Kernel Variables. worker # [ 4.016310] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 4.018181] systemd[1]: Stopped Load Kernel Modules. worker # [ 4.021210] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 7.747687] systemd[1]: Listening on Journal Log Access Socket. worker # [ 4.023201] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 4.025211] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 4.027519] systemd[1]: Stopped Create System Files and Directories. worker # [ 4.029642] systemd[1]: Stopped target Local File Systems. hub # [ 7.756052] systemd[1]: Mounted Huge Pages File System. worker # [ 4.031523] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 4.035896] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 4.037739] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 4.039285] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 7.766161] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 4.041563] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 4.043886] systemd[1]: Stopped Virtual Console Setup. hub # [ 7.776988] systemd[1]: Mounted Kernel Debug File System. worker # [ 4.053156] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 7.783890] loop: module loaded worker # [ 4.058133] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 7.786120] systemd[1]: Mounted Kernel Trace File System. hub # [ 7.788941] EXT4-fs (vda): re-mounted 3a39aab2-8a40-480b-81b0-3a5080991b97. worker # [ 4.067237] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 4.069860] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 4.072210] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 7.799029] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 4.074516] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 4.077583] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 4.080284] systemd[1]: Closed udev Control Socket. worker # [ 4.082213] systemd[1]: Starting Cleanup udev Database... worker # [ 4.084238] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 4.086198] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 7.813983] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 4.088232] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 4.091248] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 4.093115] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 7.581135] systemd[1]: Queued start job for default target Multi-User System. worker # [ 4.094871] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 7.584231] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 7.586603] systemd-modules-load[277]: Inserted module 'loop' hub # [ 7.828585] systemd[1]: Finished Load Kernel Module configfs. hub # [ 7.838357] systemd[1]: Started Journal Service. worker # [ 4.112615] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 7.601642] systemd-modules-load[277]: Inserted module 'tls' worker # [ 4.116103] systemd[1]: Finished Cleanup udev Database. worker # [ 4.117624] systemd[1]: Reached target Switch Root. worker # [ 4.120236] systemd[1]: Starting NixOS Activation... hub # [ 7.612229] systemd[1]: Mounted FUSE Control File System. hub # [ 7.617167] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 7.622102] systemd[1]: Finished Load Kernel Modules. hub # [ 7.639735] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 7.649606] systemd[1]: Mounting Kernel Configuration File System... hub # [ 7.652047] systemd-oomd[279]: No swap; memory pressure usage will be degraded hub # [ 7.658684] systemd[1]: Starting Firewall... worker # [ 4.176178] initrd-nixos-activation-start[184]: booting system configuration /nix/store/z7h3cvmg748szvj9513xr8rs0k148f0x-nixos-system-worker-test hub # [ 7.673578] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 7.676236] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 4.195522] initrd-nixos-activation-start[184]: running activation script... hub # [ 7.689109] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 7.705789] systemd[1]: Starting Apply Kernel Variables... hub # [ 7.730685] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 7.733231] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 7.738513] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. hub # [ 7.999056] systemd-journald[276]: Received client request to flush runtime journal. worker # [ 4.331630] initrd-nixos-activation-start[207]: setting up /etc... worker # [ 4.408066] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 4.410838] systemd[1]: Finished NixOS Activation. worker # [ 4.413838] systemd[1]: Starting Switch Root... worker # [ 4.427573] systemd[1]: Switching root. hub # [ 7.971752] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 7.975242] systemd[1]: Mounted Kernel Configuration File System. hub # [ 7.979319] systemd[1]: Reached target First Boot Complete. hub # [ 7.984815] systemd[1]: Finished Apply Kernel Variables. hub # [ 7.988221] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 7.991495] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 7.993319] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 8.036396] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 8.040315] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 8.045533] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 4.797875] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 8.098856] systemd[1]: Finished Coldplug All udev Devices. worker # [ 4.881652] NET: Registered PF_VSOCK protocol family hub # [ 8.139177] systemd-udevd[321]: Using default interface naming scheme 'v261'. hub # [ 8.235104] systemd[1]: Mounting /run/wrappers... hub # [ 8.271334] systemd[1]: Mounted /run/wrappers. hub # [ 8.273607] systemd[1]: Reached target Local File Systems. hub # [ 8.278223] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 8.283188] systemd[1]: Starting register-nix-paths.service... hub # [ 8.290310] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 8.291930] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 8.304899] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 8.322965] systemd[1]: Starting Create System Files and Directories... hub # [ 8.328808] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 8.388295] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 8.400874] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 8.486477] systemd[1]: Finished Create System Files and Directories. hub # [ 8.500457] systemd[1]: Starting Rebuild Journal Catalog... worker # [ 5.240589] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) worker # [ 5.256602] systemd[1]: Detected virtualization kvm. hub # [ 8.508546] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 5.259717] systemd[1]: Detected architecture x86-64. worker # [ 5.263079] systemd[1]: Detected first boot. worker # [ 5.266916] systemd[1]: Initializing machine ID from random generator. hub # [ 8.597517] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 8.650988] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 8.660784] systemd[1]: Starting Update is Completed... hub # [ 8.721905] systemd[1]: Finished Update is Completed. worker # [ 5.511156] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 8.844425] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.624400] systemd[1]: Applying preset policy. worker # [ 5.773163] systemd[1]: Populated /etc with preset unit settings. hub # [ 9.025408] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 9.030415] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 9.064101] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 5.874513] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.876827] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.880426] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.883589] systemd[1]: Created slice Slice /system/getty. worker # [ 5.885659] systemd[1]: Created slice User and Session Slice. hub # [ 9.134596] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 5.887198] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 5.889206] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.891074] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.892340] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.893656] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.895109] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.896418] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.897824] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.899354] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.900947] systemd[1]: Reached target Path Units. worker # [ 5.902239] systemd[1]: Reached target Remote File Systems. worker # [ 5.903636] systemd[1]: Reached target Slice Units. worker # [ 5.904916] systemd[1]: Reached target Swaps. worker # [ 5.906868] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.909708] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.911761] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.914082] systemd[1]: Listening on Factory Reset Management. worker # [ 5.915674] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.918777] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.920871] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.924254] systemd[1]: Listening on Console Output Muting Service Socket. hub # [ 9.173639] (udev-worker)[398]: Network interface NamePolicy= disabled on kernel command line. worker # [ 5.926186] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.928072] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.930265] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki hub # [ 9.178917] (udev-worker)[394]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 5.933882] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.935648] systemd[1]: Listening on udev Control Socket. hub # [ 9.183356] (udev-worker)[394]: Network interface NamePolicy= disabled on kernel command line. worker # [ 5.937197] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.940406] systemd[1]: Mounting Huge Pages File System... worker # [ 5.946326] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 5.953531] systemd[1]: Mounting Kernel Debug File System... worker # [ 5.963471] systemd[1]: Mounting Kernel Trace File System... worker # [ 5.979116] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 5.987733] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 6.005077] systemd[1]: Starting Load Kernel Module configfs... worker # [ 6.009109] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 6.011579] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.014208] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.021322] systemd[1]: Mounting FUSE Control File System... worker # [ 6.025317] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.038591] systemd[1]: Starting Journal Service... worker # [ 6.047117] systemd[1]: Starting Load Kernel Modules... worker # [ 6.056248] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 6.075219] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 6.083427] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.087913] systemd-journald[277]: Collecting audit messages is enabled. worker # [ 6.091798] loop: module loaded hub # [ 9.343355] systemd[1]: Finished register-nix-paths.service. hub # [ 9.346259] systemd[1]: Reached target System Initialization. hub # [ 9.349748] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 6.104301] systemd[1]: Starting Coldplug All udev Devices... hub # [ 9.352750] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 9.355556] systemd[1]: Reached target Timer Units. hub # [ 9.358665] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 9.362228] systemd[1]: Listening on Nix Daemon Socket. hub # [ 9.363645] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 9.366726] systemd[1]: Reached target Socket Units. hub # [ 9.368932] systemd[1]: Reached target Basic System. hub # [ 9.375154] systemd[1]: Started backdoor.service. worker # [ 6.130487] systemd[1]: Listening on Journal Log Access Socket. worker # [ 6.132118] EXT4-fs (vda): re-mounted 93f734dc-3715-41a6-9914-1fcb56e2267c. hub # [ 9.380368] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 6.143390] systemd[1]: Mounted Huge Pages File System. hub # [ 9.397195] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 5.911079] systemd[1]: Queued start job for default target Multi-User System. worker # [ 6.152339] systemd[1]: Started Journal Service. worker # [ 5.915497] systemd[1]: Unnecessary job was removed for /dev/vdb. worker # [ 5.918646] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 5.924217] systemd-modules-load[278]: Inserted module 'loop' worker # [ 5.928656] systemd[1]: Mounted POSIX Message Queue File System. hub # [ 9.417342] systemd[1]: Starting Post-Boot Actions... worker # [ 5.930589] systemd[1]: Mounted Kernel Debug File System. worker # [ 5.935794] systemd[1]: Mounted Kernel Trace File System. worker # [ 5.939539] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 5.943896] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 5.946579] systemd[1]: Finished Load Kernel Module configfs. hub # [ 9.434697] systemd[1]: Started Reset console on configuration changes. worker # [ 5.951643] systemd[1]: Mounted FUSE Control File System. worker # [ 5.954476] systemd[1]: Finished Load Kernel Modules. worker # [ 5.958239] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 9.455584] systemd[1]: Starting resolvconf update... worker # [ 5.971309] systemd-oomd[280]: No swap; memory pressure usage will be degraded worker # [ 5.980109] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 5.985121] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 5.989079] systemd[1]: Mounting Kernel Configuration File System... hub # [ 9.482517] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 6.001106] systemd[1]: Starting Firewall... hub # [ 9.492680] systemd[1]: Finished Firewall. worker # [ 6.006115] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 6.007846] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 6.023157] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 6.037202] systemd[1]: Starting Apply Kernel Variables... hub # connecting to host... hub # [ 9.543205] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 6.059103] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 6.061085] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 9.548272] nsncd[507]: Jul 13 14:45:18.834 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.558466] systemd[1]: Finished Post-Boot Actions. hub # [ 9.566303] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 9.568151] systemd[1]: Reached target User and Group Name Lookups. worker # [ 6.322276] systemd-journald[277]: Received client request to flush runtime journal. hub: Guest shell says: b'Spawning backdoor root shell...\n' hub: connected to guest root shell hub # [ 9.583223] systemd[1]: Starting D-Bus System Message Bus... hub: (connecting took 7.02 seconds) hub: (finished: waiting for the VM to finish booting, in 7.02 seconds) hub # [ 9.608714] systemd[1]: Starting User Login Management... hub # [ 9.618476] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 9.771930] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 9.774094] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 9.776357] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 9.781298] systemd[1]: Stopping User and Group Name Lookups... hub # [ 9.784460] dbus-broker-launch[537]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 9.791104] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 9.794173] systemd[1]: nscd.service: Deactivated successfully. hub # [ 9.798616] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 9.802620] dbus-broker-launch[537]: NSS returned no entry for 'systemd-timesync' worker # [ 6.320497] systemd[1]: Mounted Kernel Configuration File System. hub # [ 9.806222] dbus-broker-launch[537]: Invalid user-name in /nix/store/77xcfd5ihs6l9inzn2jzisj2yjk539jw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 6.327315] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 6.329543] systemd[1]: Reached target First Boot Complete. worker # [ 6.335457] systemd[1]: Finished Apply Kernel Variables. worker # [ 6.341267] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 6.343385] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 9.831577] systemd-logind[541]: New seat seat0. worker # [ 6.346912] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 6.350226] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 6.352939] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 6.356307] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 9.845387] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 9.847067] systemd[1]: Started User Login Management. worker # [ 6.360444] systemd-udevd[316]: Using default interface naming scheme 'v261'. hub # [ 9.857211] systemd[1]: Started D-Bus System Message Bus. hub # [ 9.904155] dbus-broker-launch[537]: Ready hub # [ 10.150425] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.431223] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 9.937594] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 9.940430] nsncd[592]: Jul 13 14:45:19.231 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.946131] systemd[1]: Finished resolvconf update. hub # [ 9.950190] systemd[1]: Reached target Preparation for Network. hub # [ 9.951746] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 9.955204] systemd[1]: Reached target User and Group Name Lookups. hub # [ 9.964673] systemd[1]: Starting DHCP Client... hub # [ 9.968964] systemd[1]: Starting linger-users.service... hub # [ 9.983104] systemd[1]: Starting Address configuration of eth1... worker # [ 6.507695] systemd[1]: Finished Coldplug All udev Devices. hub # [ 9.997755] systemd[1]: Starting Extra networking commands.... hub # [ 10.238231] ACPI: button: Power Button [PWRF] hub # [ 10.254003] mousedev: PS/2 mouse device common for all mice hub # [ 10.034844] systemd[1]: Starting Tailscale node agent... hub # [ 10.070877] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 10.073521] systemd[1]: Finished linger-users.service. worker # [ 6.645199] systemd[1]: Mounting /run/wrappers... worker # [ 6.675112] systemd[1]: Mounted /run/wrappers. worker # [ 6.676456] systemd[1]: Reached target Local File Systems. worker # [ 6.679116] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 10.167139] network-addresses-eth1-start[615]: adding address 192.168.1.1/24... done worker # [ 6.687877] systemd[1]: Starting register-nix-paths.service... worker # [ 6.695112] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 6.698811] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 10.194157] network-addresses-eth1-start[615]: adding address 2001:db8:1::1/64... done worker # [ 6.709380] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 6.731729] systemd[1]: Starting Create System Files and Directories... hub # [ 10.470301] rtc_cmos 00:05: RTC can wake from S4 hub # [ 10.233632] systemd[1]: Finished Address configuration of eth1. worker # [ 6.753143] systemd[1]: Finished Firewall. worker # [ 6.790680] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 6.801232] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 10.536657] Floppy drive(s): fd0 is 2.88M AMI BIOS worker # [ 6.838564] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.847801] systemd[1]: Finished Create System Files and Directories. hub # [ 10.335537] systemd[1]: Finished Extra networking commands.. hub # [ 10.343565] systemd[1]: Reached target Network. worker # [ 6.859702] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 10.589409] parport_pc 00:03: reported by Plug and Play ACPI hub # [ 10.354654] systemd[1]: Starting Nginx Web Server... hub # [ 10.361638] dhcpcd[636]: dhcpcd-10.3.2 starting worker # [ 6.875163] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 10.606135] rtc_cmos 00:05: registered as rtc0 hub # [ 10.369353] systemd[1]: Starting Permit User Sessions... hub # [ 10.376538] dhcpcd[683]: dev: loaded udev hub # [ 10.625264] rtc_cmos 00:05: setting system clock to 2026-07-13T14:45:19 UTC (1783953919) hub # [ 10.629244] systemd-journald[276]: Time jumped backwards, rotating. hub # [ 10.645999] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console hub # [ 10.662306] 8021q: 802.1Q VLAN Support v1.8 hub # [ 10.663403] 8021q: adding VLAN 0 to HW filter on device eth1 hub # [ 10.671308] FDC 0 is a S82078B hub # [ 10.674325] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 6.950144] systemd[1]: Finished Record System Boot/Shutdown in UTMP. hub # [ 10.698891] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 worker # [ 6.997791] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.008681] systemd[1]: Starting Update is Completed... hub # [ 10.496119] systemd[1]: Finished Permit User Sessions. hub # [ 10.506285] systemd[1]: Started Getty on tty1. hub # [ 10.511169] systemd[1]: Reached target Login Prompts. hub # [ 10.758082] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 10.543699] tailscaled[618]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 7.059807] systemd[1]: Finished Update is Completed. hub # [ 10.574155] tailscaled[618]: logtail started hub # [ 10.583542] tailscaled[618]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} hub # [ 10.588693] tailscaled[618]: LogID: ea7909d2eacddcd82f30a888774760b8fe83c2a4c04bd234952ba18b0a63de2c hub # [ 10.591271] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 10.594140] tailscaled[618]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 10.598776] tailscaled[618]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil hub # [ 10.633468] dbus-broker-launch[537]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 7.157418] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 7.163395] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 7.169143] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 10.688163] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 10.690186] tailscaled[618]: dns: using "openresolv" mode hub # [ 10.697422] tailscaled[618]: dns: using dns.openresolvManager worker # [ 7.229077] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 7.249139] (udev-worker)[393]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 7.252877] (udev-worker)[393]: Network interface NamePolicy= disabled on kernel command line. worker # [ 7.257331] (udev-worker)[403]: Network interface NamePolicy= disabled on kernel command line. hub # [ 10.810469] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 7.328628] systemd[1]: Finished register-nix-paths.service. worker # [ 7.333880] systemd[1]: Reached target System Initialization. worker # [ 7.336181] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 7.338507] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 7.341639] systemd[1]: Reached target Timer Units. worker # [ 7.343241] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 7.345232] systemd[1]: Listening on Nix Daemon Socket. worker # [ 7.347253] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 10.851319] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 hub # [ 10.955531] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 7.350646] systemd[1]: Listening on tribuchet-sandboxd.socket. worker # [ 7.352700] systemd[1]: Reached target Socket Units. worker # [ 7.354501] systemd[1]: Reached target Basic System. worker # [ 7.356841] systemd[1]: Started backdoor.service. worker # [ 7.367100] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 10.855256] nginx-pre-start[695]: nginx: the configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf syntax is ok hub # [ 10.859449] nginx-pre-start[695]: nginx: configuration file /nix/store/v3m5k4r0hj81f31xfwf01jvld76m3g46-nginx.conf test is successful hub # [ 10.865678] dhcpcd[683]: eth0: waiting for carrier worker # [ 7.379669] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 10.867839] dhcpcd[683]: eth0: carrier acquired worker # [ 7.392153] systemd[1]: Starting Post-Boot Actions... hub # [ 10.880303] systemd[1]: Started Nginx Web Server. hub # [ 10.890945] dhcpcd[683]: DUID 00:01:00:01:31:e7:b6:80:52:54:00:12:34:56 hub # [ 10.892686] dhcpcd[683]: eth0: IAID 00:12:34:56 hub # [ 10.896409] dhcpcd[683]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 7.411206] systemd[1]: Started Reset console on configuration changes. hub # [ 10.898711] dhcpcd[683]: eth0: soliciting a DHCP lease worker # connecting to host... worker # [ 7.426936] systemd[1]: Starting resolvconf update... hub # [ 10.964525] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 10.936647] dhcpcd[683]: eth0: offered 10.0.2.15 from 10.0.2.2 hub # [ 10.942648] dhcpcd[683]: eth0: probing address 10.0.2.15/24 worker # [ 7.461642] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 7.484265] nsncd[504]: Jul 13 14:45:20.270 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.493213] systemd[1]: Finished Post-Boot Actions. worker # [ 7.494570] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 10.964982] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 hub # [ 10.996194] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 7.514731] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.518315] systemd[1]: Reached target User and Group Name Lookups. worker # [ 7.524950] systemd[1]: Starting D-Bus System Message Bus... worker # [ 7.547188] systemd[1]: Starting User Login Management... worker # [ 7.558953] systemd[1]: Finished Import lastlog data into lastlog2 database. hub # [ 11.087478] systemd[1]: Starting Virtual Console Setup... hub # [ 10.996307] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 10.998324] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 7.629413] dbus-broker-launch[529]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 7.634112] dbus-broker-launch[529]: NSS returned no entry for 'systemd-timesync' worker # [ 7.635958] dbus-broker-launch[529]: Invalid user-name in /nix/store/a7agjv2209jvj4cvwy8lz4g35l9gak1c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 7.647273] systemd[1]: Started D-Bus System Message Bus. hub # [ 11.146431] systemd[1]: Started Tailscale node agent. hub # [ 11.150206] tailscaled[618]: wgengine.NewUserspaceEngine(tun "tailscale0") ... hub # [ 10.998331] cfg80211: failed to load regulatory.db worker # [ 7.678304] dbus-broker-launch[529]: Ready hub # [ 11.027419] Console: switching to colour dummy device 80x25 hub # [ 11.102885] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 11.165535] NET: Registered PF_PACKET protocol family hub # [ 11.411175] tun: Universal TUN/TAP device driver, 1.6 worker # [ 7.699871] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 7.704817] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 11.432043] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 7.706434] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 11.432045] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 7.710706] systemd[1]: Stopping User and Group Name Lookups... hub # [ 11.183774] systemd-logind[541]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 7.712596] systemd-logind[533]: New seat seat0. hub # [ 11.440027] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic hub # [ 11.441274] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 worker # [ 7.716977] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 7.719359] systemd[1]: nscd.service: Deactivated successfully. worker # [ 7.721500] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 7.724295] systemd[1]: nscd.service: Consumed 17ms CPU time over 329ms wall clock time, 6.8M memory peak, 5.5M read from disk. worker # [ 7.730914] systemd[1]: Started User Login Management. hub # [ 11.234842] tailscaled[618]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 7.748266] systemd[1]: Starting linger-users.service... hub # [ 11.237106] tailscaled[618]: dns: using "openresolv" mode worker # [ 7.756508] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 11.253859] tailscaled[618]: dns: using dns.openresolvManager hub # [ 11.256276] tailscaled[618]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} hub # [ 11.271522] tailscaled[618]: magicsock: disco key = d:51eb17f52354aae5 hub # [ 11.273655] tailscaled[618]: Creating WireGuard device... hub # [ 11.277648] tailscaled[618]: Bringing WireGuard device up... worker # [ 7.791464] systemd[1]: Finished resolvconf update. hub # [ 11.280651] tailscaled[618]: Bringing router up... hub # [ 11.282788] tailscaled[618]: router: using firewall mode pref worker # [ 7.799188] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 11.291552] tailscaled[618]: router: portUpdate(port=41641, network=udp6) worker # [ 7.805403] systemd[1]: Finished linger-users.service. worker # [ 7.808584] systemd[1]: Reached target Preparation for Network. hub # [ 11.304407] tailscaled[618]: external route: up worker # [ 7.821414] nsncd[581]: Jul 13 14:45:20.607 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.825289] systemd[1]: Starting DHCP Client... worker # [ 8.068889] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 hub # [ 11.500596] fbcon: bochs-drmdrmfb (fb0) is primary device worker # [ 7.833192] systemd[1]: Starting Address configuration of eth1... worker # [ 7.842943] systemd[1]: Starting Extra networking commands.... hub # [ 11.556753] Console: switching to colour frame buffer device 160x50 hub # [ 11.575255] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 7.859377] systemd[1]: Starting Tailscale node agent... worker # [ 7.869314] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.883499] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.889187] systemd[1]: Reached target User and Group Name Lookups. hub # [ 11.385383] tailscaled[618]: router: default choosing iptables hub # [ 11.655556] kvm_amd: TSC scaling supported hub # [ 11.656571] kvm_amd: Nested Virtualization enabled hub # [ 11.658305] kvm_amd: Nested Paging enabled worker # [ 7.931872] network-addresses-eth1-start[600]: adding address 192.168.1.2/24... done hub # [ 11.659660] kvm_amd: LBR virtualization supported hub # [ 11.661153] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 11.663094] kvm_amd: Virtual GIF supported hub # [ 11.664352] kvm_amd: Virtual NMI enabled worker # [ 7.953679] network-addresses-eth1-start[600]: adding address 2001:db8:1::2/64... done hub # [ 11.454765] tailscaled[618]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 11.461763] tailscaled[618]: Clearing router settings... hub # [ 11.463384] tailscaled[618]: Starting network monitor... hub # [ 11.466926] tailscaled[618]: Engine created. worker # [ 7.979936] systemd[1]: Finished Address configuration of eth1. worker # [ 8.237025] ACPI: button: Power Button [PWRF] hub # [ 11.487226] tailscaled[618]: router: portUpdate(port=41641, network=udp4) hub # [ 11.498823] tailscaled[618]: pm: migrating "_daemon" profile to new format hub # [ 11.501469] tailscaled[618]: envknob: PORT="41641" hub # [ 11.514188] tailscaled[618]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 11.518173] tailscaled[618]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 8.273470] rtc_cmos 00:05: RTC can wake from S4 hub # [ 11.525108] tailscaled[618]: got LocalBackend in 380ms hub # [ 11.527431] tailscaled[618]: Start hub # [ 11.529167] tailscaled[618]: ipnext: "conn25": skipping extension hub # [ 11.531170] tailscaled[618]: ipnext: active extensions: posture, clientupdate, relayserver, taildrop, conn25, portlist hub # [ 11.541769] tailscaled[618]: profile data directory: profile not found hub # [ 11.783628] EDAC MC: Ver: 3.0.0 hub # [ 11.547887] tailscaled[618]: Backend: logs: be:ea7909d2eacddcd82f30a888774760b8fe83c2a4c04bd234952ba18b0a63de2c fe: hub # [ 11.553224] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 11.556090] tailscaled[618]: blockEngineUpdates(true) hub # [ 11.559886] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 11.562822] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 11.564322] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 11.566830] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 11.570251] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 11.572241] tailscaled[618]: dns: OScfg: {} hub # [ 11.597266] tailscaled[618]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 8.379494] rtc_cmos 00:05: registered as rtc0 hub # [ 11.639545] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 8.160911] tailscaled[602]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 8.402868] Floppy drive(s): fd0 is 2.88M AMI BIOS worker # [ 8.170106] tailscaled[602]: logtail started hub # [ 11.659576] systemd-logind[541]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 8.171359] tailscaled[602]: Program starting: v1.98.8, Go 1.26.4: []string{"/nix/store/xvzadxzbjg2kw95sjw8a2laxb1w4xry5-tailscale-1.98.8/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} worker # [ 8.177053] tailscaled[602]: LogID: da95af73858721e27b9f43b99aae8d7246d809e1905f79727bb76e5b40132200 worker # [ 8.179194] tailscaled[602]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.183078] tailscaled[602]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 8.187342] tailscaled[602]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil hub # [ 11.923314] ppdev: user-space parallel port driver worker # [ 8.196400] dbus-broker-launch[529]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 8.441818] FDC 0 is a S82078B hub # [ 11.693421] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 11.697182] systemd[1]: Stopped Virtual Console Setup. hub # [ 11.706439] systemd[1]: Starting Virtual Console Setup... worker # [ 8.222192] dhcpcd[619]: dhcpcd-10.3.2 starting worker # [ 8.223597] tailscaled[602]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:57284->[::1]:53: read: connection refused (in 31ms), trying bootstrap... worker # [ 8.470628] mousedev: PS/2 mouse device common for all mice worker # [ 8.234883] dhcpcd[668]: dev: loaded udev worker # [ 8.242519] systemd[1]: Finished Extra networking commands.. hub # [ 11.735504] (udev-worker)[770]: Network interface NamePolicy= disabled on kernel command line. worker # [ 8.249243] systemd[1]: Reached target Network. worker # [ 8.490302] 8021q: 802.1Q VLAN Support v1.8 worker # [ 8.255253] tailscaled[602]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ... worker # [ 8.257698] systemd[1]: Starting Permit User Sessions... worker # [ 8.502188] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.265865] tailscaled[602]: 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 # [ 8.270420] tailscaled[602]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... worker # [ 8.275728] tailscaled[602]: bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7a0:e001]:443: connect: network is unreachable worker # [ 8.280717] tailscaled[602]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ... worker # [ 8.289175] tailscaled[602]: 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 # [ 8.293710] tailscaled[602]: trying bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" ... worker # [ 8.540106] parport_pc 00:03: reported by Plug and Play ACPI worker # [ 8.541589] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 8.306438] tailscaled[602]: bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::44c]:443: connect: network is unreachable hub # [ 11.798392] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 8.311208] tailscaled[602]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... worker # [ 8.313554] tailscaled[602]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable hub # [ 11.804194] systemd[1]: Stopped Virtual Console Setup. worker # [ 8.322230] tailscaled[602]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ... hub # [ 11.814208] systemd[1]: Starting Virtual Console Setup... worker # [ 8.325040] tailscaled[602]: 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": dial tcp [2001:19f0:5c01:289:5400:3ff:fe8d:cb5e]:443: connect: network is unreachable worker # [ 8.330378] tailscaled[602]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... worker # [ 8.332913] tailscaled[602]: 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 # [ 8.340289] tailscaled[602]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... worker # [ 8.343113] tailscaled[602]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2401:c080:1000:467f:5400:2ff:feee:22aa]:443: connect: network is unreachable worker # [ 8.348517] tailscaled[602]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... hub # [ 11.838623] systemd-logind[541]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 8.350913] tailscaled[602]: bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.134:443: connect: network is unreachable worker # [ 8.359080] tailscaled[602]: trying bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" ... worker # [ 8.361866] tailscaled[602]: bootstrapDNS("derp12c.tailscale.com", "2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:2cb:5400:3ff:fe8d:cb60]:443: connect: network is unreachable worker # [ 8.368132] tailscaled[602]: trying bootstrapDNS("derp9.tailscale.com", "207.148.3.137") for "log.tailscale.com" ... worker # [ 8.370539] tailscaled[602]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.375129] tailscaled[602]: dns: using "openresolv" mode worker # [ 8.376462] tailscaled[602]: dns: using dns.openresolvManager worker # [ 8.382524] tailscaled[602]: 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 worker # [ 8.387090] tailscaled[602]: trying bootstrapDNS("derp6.tailscale.com", "2400:6180:100:d0::982:d001") for "log.tailscale.com" ... worker # [ 8.389672] tailscaled[602]: 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 # [ 8.395163] tailscaled[602]: logtail: upload: log upload of 475 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/e88b214e4ac8e817a3c8078d3e26ab3609341f960449eef117e04b078b179746": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 8.404213] systemd[1]: Finished Permit User Sessions. worker # [ 8.411987] systemd[1]: Started Getty on tty1. worker # [ 8.418985] systemd[1]: Reached target Login Prompts. worker # [ 8.696023] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console worker # [ 8.620870] tailscaled[602]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 8.622878] systemd[1]: Started Tailscale node agent. worker # [ 8.642798] dhcpcd[668]: eth0: waiting for carrier worker # [ 8.644170] dhcpcd[668]: eth0: carrier acquired worker # [ 8.658179] dhcpcd[668]: DUID 00:01:00:01:31:e7:b6:81:52:54:00:12:34:56 worker # [ 8.659860] dhcpcd[668]: eth0: IAID 00:12:34:56 worker # [ 8.662272] dhcpcd[668]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 8.670655] tailscaled[602]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.672534] tailscaled[602]: dns: using "openresolv" mode worker # [ 8.679464] tailscaled[602]: dns: using dns.openresolvManager worker # [ 8.682741] tailscaled[602]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 8.686809] tailscaled[602]: router: portUpdate(port=41641, network=udp6) worker # [ 8.690173] tailscaled[602]: router: using firewall mode pref worker # [ 8.704858] tailscaled[602]: router: default choosing iptables worker # [ 8.715110] tailscaled[602]: magicsock: disco key = d:6e6961cbbd9de288 worker # [ 8.716670] tailscaled[602]: Creating WireGuard device... worker # [ 8.718083] tailscaled[602]: Bringing WireGuard device up... worker # [ 8.719464] tailscaled[602]: Bringing router up... worker # [ 8.730554] tailscaled[602]: external route: up worker # [ 8.753134] tailscaled[602]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 8.755625] tailscaled[602]: router: portUpdate(port=41641, network=udp4) worker # [ 8.759685] tailscaled[602]: Clearing router settings... worker # [ 8.761148] tailscaled[602]: Starting network monitor... worker # [ 8.762483] tailscaled[602]: Engine created. hub # [ 12.250880] systemd-vconsole-setup[792]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 12.256307] systemd[1]: Finished Virtual Console Setup. worker # [ 8.805795] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 worker # [ 8.772436] tailscaled[602]: pm: migrating "_daemon" profile to new format worker # [ 8.774112] tailscaled[602]: envknob: PORT="41641" worker # [ 8.775945] tailscaled[602]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.778884] tailscaled[602]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 8.783928] tailscaled[602]: got LocalBackend in 165ms worker # [ 8.786188] tailscaled[602]: Start worker # [ 8.787178] tailscaled[602]: ipnext: "conn25": skipping extension worker # [ 8.788683] tailscaled[602]: ipnext: active extensions: posture, clientupdate, relayserver, taildrop, conn25, portlist worker # [ 8.793441] tailscaled[602]: profile data directory: profile not found worker # [ 8.795744] tailscaled[602]: Backend: logs: be:da95af73858721e27b9f43b99aae8d7246d809e1905f79727bb76e5b40132200 fe: worker # [ 8.799242] tailscaled[602]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 8.803100] tailscaled[602]: blockEngineUpdates(true) worker # [ 8.804389] tailscaled[602]: wgengine: Reconfig: configuring router worker # [ 8.808043] tailscaled[602]: wgengine: Reconfig: user dialer worker # [ 8.809436] tailscaled[602]: wgengine: Reconfig: configuring DNS worker # [ 8.810920] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 8.814095] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 8.816612] tailscaled[602]: dns: OScfg: {} worker # [ 8.819167] tailscaled[602]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 8.805864] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 8.808219] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 8.813822] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.813934] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.885702] systemd[1]: Starting Virtual Console Setup... worker # [ 8.814116] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.814123] cfg80211: failed to load regulatory.db worker # [ 8.816485] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 worker # [ 8.836134] rtc_cmos 00:05: setting system clock to 2026-07-13T14:45:21 UTC (1783953921) worker # [ 8.836317] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 8.871469] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.880999] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.963037] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 8.963414] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 9.008701] Console: switching to colour dummy device 80x25 worker # [ 9.231816] ppdev: user-space parallel port driver worker # [ 8.948413] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 9.081795] systemd-logind[533]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 9.085304] systemd-logind[533]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 9.087566] (udev-worker)[391]: Network interface NamePolicy= disabled on kernel command line. worker # [ 9.089618] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 9.091870] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.094106] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.104113] systemd[1]: Starting Virtual Console Setup... worker # [ 9.344650] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 9.350512] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 9.362070] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic worker # [ 9.370353] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 hub # [ 12.613662] tailscaled[618]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:36312->[::1]:53: read: connection refused (in 11ms), trying bootstrap... hub # [ 12.631502] tailscaled[618]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ... hub # [ 12.638188] tailscaled[618]: 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 # [ 12.646405] tailscaled[618]: trying bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" ... hub # [ 12.648917] tailscaled[618]: bootstrapDNS("derp4c.tailscale.com", "2a03:b0c0:3:d0::1501:6001") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:6001]:443: connect: network is unreachable hub # [ 12.653741] tailscaled[618]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ... hub # [ 12.656428] tailscaled[618]: 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 worker # [ 9.382043] fbcon: bochs-drmdrmfb (fb0) is primary device hub # [ 12.661129] tailscaled[618]: trying bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" ... worker # [ 9.405769] Console: switching to colour frame buffer device 160x50 worker # [ 9.407852] erofs (device vdb): failed to read inode meta block (nid: 766848): -4 hub # [ 12.664178] tailscaled[618]: bootstrapDNS("derp9.tailscale.com", "2001:19f0:6401:1d9c:5400:2ff:feef:bb82") for "log.tailscale.com" error: Get "https://derp9.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:1d9c:5400:2ff:feef:bb82]:443: connect: network is unreachable worker # [ 9.421991] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device hub # [ 12.670188] tailscaled[618]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ... worker # [ 9.187563] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 12.672527] tailscaled[618]: 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 # [ 9.190235] systemd[1]: Stopped Virtual Console Setup. hub # [ 12.676932] tailscaled[618]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ... hub # [ 12.679401] tailscaled[618]: bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:0:d1::67d:8001]:443: connect: network is unreachable hub # [ 12.685102] tailscaled[618]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... hub # [ 12.687425] tailscaled[618]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable hub # [ 12.691820] tailscaled[618]: trying bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" ... hub # [ 12.694248] tailscaled[618]: bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::44c]:443: connect: network is unreachable hub # [ 12.699135] tailscaled[618]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ... worker # [ 9.214860] systemd[1]: Starting Virtual Console Setup... hub # [ 12.702181] tailscaled[618]: 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 # [ 12.706601] tailscaled[618]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ... hub # [ 12.709150] tailscaled[618]: bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:0:d1::67d:8001]:443: connect: network is unreachable hub # [ 12.714416] tailscaled[618]: trying bootstrapDNS("derp10.tailscale.com", "137.220.36.168") for "log.tailscale.com" ... hub # [ 12.716784] tailscaled[618]: 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 # [ 12.721428] tailscaled[618]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ... hub # [ 12.724656] tailscaled[618]: bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::873:4001]:443: connect: network is unreachable hub # [ 12.729603] tailscaled[618]: logtail: upload: log upload of 2743 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/88d130763978ff684aae49389cdf1c829c35199e4c49a592443a16a9bfdc414a": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 9.503877] kvm_amd: TSC scaling supported worker # [ 9.269445] systemd-vconsole-setup[739]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.512323] kvm_amd: Nested Virtualization enabled worker # [ 9.274822] systemd[1]: Finished Virtual Console Setup. worker # [ 9.515259] kvm_amd: Nested Paging enabled worker # [ 9.517467] kvm_amd: LBR virtualization supported worker # [ 9.519174] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 9.520284] kvm_amd: Virtual GIF supported worker # [ 9.521247] kvm_amd: Virtual NMI enabled worker # [ 9.550591] EDAC MC: Ver: 3.0.0 worker # [ 9.548936] dhcpcd[668]: eth0: soliciting a DHCP lease worker # [ 9.802655] NET: Registered PF_PACKET protocol family worker # [ 9.569880] dhcpcd[668]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 9.575538] dhcpcd[668]: eth0: probing address 10.0.2.15/24 hub # [ 13.691464] dhcpcd[683]: eth0: soliciting an IPv6 router hub # [ 13.697357] dhcpcd[683]: eth0: Router Advertisement from fe80::2 hub # [ 13.702283] dhcpcd[683]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 13.706962] dhcpcd[683]: eth0: adding route to fec0::/64 hub # [ 13.712541] dhcpcd[683]: eth0: adding default route via fe80::2 hub # [ 13.722221] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 13.728319] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 13.737242] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] rebind-reason=[default-if-changed] hub # [ 13.758437] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 13.761758] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 13.763592] tailscaled[618]: dns: OScfg: {} hub # [ 13.813233] tailscaled[618]: wgengine: set DNS config again after major link change hub # [ 13.815972] tailscaled[618]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] hub # [ 13.818981] tailscaled[618]: magicsock: 0 active derp conns hub # [ 13.821802] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 13.823785] tailscaled[618]: router: portUpdate(port=41641, network=udp4) worker # [ 10.629430] dhcpcd[668]: eth0: soliciting an IPv6 router worker # [ 10.635361] dhcpcd[668]: eth0: Router Advertisement from fe80::2 worker # [ 10.641125] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 10.647437] dhcpcd[668]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 10.651618] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 10.656923] dhcpcd[668]: eth0: adding route to fec0::/64 worker # [ 10.661733] dhcpcd[668]: eth0: adding default route via fe80::2 worker # [ 10.785661] tailscaled[602]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] rebind-reason=[default-if-changed] worker # [ 10.809744] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 10.816447] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 10.820751] tailscaled[602]: dns: OScfg: {} worker # [ 10.840097] tailscaled[602]: wgengine: set DNS config again after major link change worker # [ 10.842558] tailscaled[602]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] worker # [ 10.846101] tailscaled[602]: magicsock: 0 active derp conns worker # [ 10.847698] tailscaled[602]: router: portUpdate(port=41641, network=udp6) worker # [ 10.849736] tailscaled[602]: router: portUpdate(port=41641, network=udp4) hub # [ 15.143837] dhcpcd[683]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 15.152428] dhcpcd[683]: eth0: adding route to 10.0.2.0/24 hub # [ 15.157781] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 15.165492] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 15.171305] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 15.177328] tailscaled[618]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 15.182761] dhcpcd[683]: eth0: adding default route via 10.0.2.2 hub # [ 15.297216] systemd[1]: Started DHCP Client. hub # [ 15.300378] systemd[1]: Reached target Network is Online. hub # [ 15.305767] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 15.307930] systemd[1]: Reached target Multi-User System. hub # [ 15.310322] systemd[1]: Startup finished in 980ms (kernel) + 4.385s (initrd) + 9.943s (userspace) = 15.309s. hub # [ 15.413063] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::ca87:7a2:7f2b:8a66/128, gw=, outif=2, table=255 hub: (finished: waiting for unit headscale, in 12.89 seconds) hub: waiting for TCP port 443 on localhost worker # [ 12.019952] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.08 seconds) hub: waiting for unit tailscaled hub # [ 15.540961] tailscaled[618]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub: (finished: waiting for unit tailscaled, in 0.09 seconds) worker: waiting for unit tailscaled worker: waiting for the VM to finish booting worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 0.00 seconds) worker: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker: (finished: waiting for unit tailscaled, in 0.04 seconds) hub: must succeed: headscale users create test hub # [ 15.742853] tailscaled[618]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] rebind-reason=[ips-changed] hub # [ 15.768442] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 15.771098] tailscaled[618]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 15.772923] tailscaled[618]: dns: OScfg: {} hub # [ 15.786564] headscale-start[873]: 2026-07-13T14:45:24Z WRN hub # [ 15.789251] headscale-start[873]: WARN: The "ephemeral_node_inactivity_timeout" configuration key is deprecated. Please use "node.ephemeral.inactivity_timeout" instead. "ephemeral_node_inactivity_timeout" has been removed. hub # [ 15.797680] headscale-start[873]: 2026-07-13T14:45:24Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 15.803349] headscale-start[873]: 2026-07-13T14:45:24Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 15.834092] tailscaled[618]: wgengine: set DNS config again after major link change hub # [ 15.836155] tailscaled[618]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ca87:7a2:7f2b:8a66/64] hub # [ 15.840296] tailscaled[618]: magicsock: 0 active derp conns hub # [ 15.845583] tailscaled[618]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 15.850793] tailscaled[618]: router: portUpdate(port=41641, network=udp6) hub # [ 15.855602] tailscaled[618]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 15.913917] headscale-start[873]: 2026-07-13T14:45:25Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 15.922623] headscale-start[873]: 2026-07-13T14:45:25Z INF starting headscale commit=v0.29.2 version=0.29.2 hub # [ 15.926053] headscale-start[873]: 2026-07-13T14:45:25Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 15.929185] headscale-start[873]: 2026-07-13T14:45:25Z 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:[0xc28caada120]} hub # [ 15.934455] headscale-start[873]: 2026-07-13T14:45:25Z 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 # [ 15.947168] headscale-start[873]: 2026-07-13T14:45:25Z INF stun server started at [::]:3478 hub # [ 15.950890] headscale-start[873]: 2026-07-13T14:45:25Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 15.955154] headscale-start[873]: 2026-07-13T14:45:25Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 15.959309] headscale-start[873]: 2026-07-13T14:45:25Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 15.961528] headscale-start[873]: 2026-07-13T14:45:25Z INF metrics server disabled (metrics_listen_addr is empty) worker # [ 12.656961] tailscaled[602]: monitor: RTM_NEWROUTE: src=, dst=fec0::ff5d:548a:fda7:4253/128, gw=, outif=2, table=255 hub # [ 16.856541] headscale-start[873]: 2026-07-13T14:45:25Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 1.21 seconds) hub: must succeed: headscale preauthkeys -u 1 create --reusable hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.13 seconds) hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-yAk4hGiQzepK-UXMElRv_eEhnnGN_NSRzOjsynyJEiACYBZ0OM9dPFJDetaURAhalrsfoSNKSJ0kI --hostname hub hub # [ 17.067758] tailscaled[618]: localapi: [POST] /localapi/v0/check-prefs hub # [ 17.070744] tailscaled[618]: localapi: [POST] /localapi/v0/start hub # [ 17.072603] tailscaled[618]: Start hub # [ 17.074561] tailscaled[618]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="hub" update=check Persist=nil}, reason: [opts.UpdatePrefs] hub # [ 17.078831] tailscaled[618]: generating new machine key hub # [ 17.084453] tailscaled[618]: machine key written to store hub # [ 17.085832] tailscaled[618]: profile data directory: profile not found hub # [ 17.089210] tailscaled[618]: Backend: logs: be:ea7909d2eacddcd82f30a888774760b8fe83c2a4c04bd234952ba18b0a63de2c fe: hub # [ 17.092182] tailscaled[618]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 17.094739] tailscaled[618]: blockEngineUpdates(true) hub # [ 17.096397] tailscaled[618]: Reconfig(down): no changes made to Engine config hub # [ 17.100150] tailscaled[618]: control: client.Shutdown ... hub # [ 17.101513] tailscaled[618]: control: updateRoutine: exiting hub # [ 17.108162] tailscaled[618]: control: authRoutine: exiting hub # [ 17.109742] tailscaled[618]: control: mapRoutine: exiting hub # [ 17.112087] tailscaled[618]: control: Client.Shutdown done. hub # [ 17.113494] tailscaled[618]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 17.115562] tailscaled[618]: health(warnable=wantrunning-false): ok hub # [ 17.117223] tailscaled[618]: localapi: [POST] /localapi/v0/login-interactive hub # [ 17.120240] tailscaled[618]: StartLoginInteractiveAs("root"): url=false hub # [ 17.121816] tailscaled[618]: control: client.Login(2) hub # [ 17.124271] tailscaled[618]: control: LoginInteractive -> regen=true hub # [ 17.125908] tailscaled[618]: control: doLogin(regen=true, hasUrl=false) hub # [ 17.207264] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 17.223989] headscale-start[873]: 2026-07-13T14:45:26Z INF http request bytes=176 elapsed=2.921601 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:33454 status=200 hub # [ 17.232604] tailscaled[618]: control: control server key from https://hub: ts2021=[A4Rue], legacy= hub # [ 17.235503] tailscaled[618]: control: Generating a new nodekey. hub # [ 17.243952] tailscaled[618]: control: RegisterReq: onode= node=[ly23T] fup=false nks=false worker # [ 14.420749] dhcpcd[668]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 14.428272] dhcpcd[668]: eth0: adding route to 10.0.2.0/24 worker # [ 14.434764] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 14.444590] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 14.451790] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 14.460257] tailscaled[602]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 14.466865] dhcpcd[668]: eth0: adding default route via 10.0.2.2 hub # [ 17.954761] headscale-start[873]: 2026-07-13T14:45:27Z INF http request bytes=248 elapsed=690.840317 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:33458 status=200 hub # [ 17.965527] tailscaled[618]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 14.475634] tailscaled[602]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] rebind-reason=[ips-changed] hub # [ 17.983332] tailscaled[618]: blockEngineUpdates(false) worker # [ 14.497315] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 14.501137] tailscaled[602]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 14.503110] tailscaled[602]: dns: OScfg: {} worker # [ 14.557894] systemd[1]: Started DHCP Client. worker # [ 14.561324] systemd[1]: Reached target Multi-User System. worker # [ 14.563587] systemd[1]: Startup finished in 970ms (kernel) + 3.651s (initrd) + 9.941s (userspace) = 14.563s. hub # [ 18.459272] headscale-start[873]: 2026-07-13T14:45:27Z INF http request bytes=0 elapsed=476.024746 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33458 status=200 hub # [ 18.958810] headscale-start[873]: 2026-07-13T14:45:28Z INF node connected machine.key=[Q4une] node.expired=false node.id=1 node.is_tagged=false node.key=[ly23T] node.name=hub node.online=true user.name=test hub # [ 18.969642] headscale-start[873]: 2026-07-13T14:45:28Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0xc28ca822a80 component=poll machine.key=[Q4une] node.expired=false node.id=1 node.is_tagged=false node.key=[ly23T] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 19.014844] tailscaled[618]: health(warnable=not-in-map-poll): ok worker # [ 15.542564] tailscaled[602]: wgengine: set DNS config again after major link change hub # [ 19.034712] tailscaled[618]: active login: test worker # [ 15.548390] tailscaled[602]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::ff5d:548a:fda7:4253/64] hub # [ 19.042340] tailscaled[618]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 19.044698] tailscaled[618]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 15.557615] tailscaled[602]: magicsock: 0 active derp conns hub # [ 19.049114] tailscaled[618]: magicsock: SetPrivateKey called (init) hub # [ 19.050633] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 0 peers) hub # [ 19.052730] tailscaled[618]: wgengine: Reconfig: configuring router worker # [ 15.569431] tailscaled[602]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 15.576206] tailscaled[602]: router: portUpdate(port=41641, network=udp6) worker # [ 15.581699] tailscaled[602]: router: portUpdate(port=41641, network=udp4) worker # [ 15.585174] tailscaled[602]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 19.310958] tailscaled[618]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [1ms] (forced=false) hub # [ 19.313728] tailscaled[618]: magicsock: home is now derp-999 () hub # [ 19.317440] tailscaled[618]: magicsock: endpoints changed: 127.0.0.1:41641 (stun), [2001:db8:1::1]:41641 (stun), 10.0.2.15:41641 (local), 192.168.1.1:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::ca87:7a2:7f2b:8a66]:41641 (local) hub # [ 19.322613] tailscaled[618]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 19.325222] tailscaled[618]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 19.328124] tailscaled[618]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 19.333954] tailscaled[618]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 19.348100] tailscaled[618]: magicsock: derp-999 connected; connGen=1 hub # [ 19.572191] tailscaled[618]: router: enabling connmark-based rp_filter workaround hub # [ 19.673790] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 19.676342] tailscaled[618]: tsdial: bart table size: 2 hub # [ 19.677832] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 19.679750] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:1} hub # [ 19.730437] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:1 LocalDomains:[tailnet.]+65arpa} hub # [ 19.732946] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 19.814752] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 19.818277] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 19.820821] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 19.823219] systemd[1]: Stopping User and Group Name Lookups... hub # [ 19.825282] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 19.828404] systemd[1]: nscd.service: Deactivated successfully. hub # [ 19.830695] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 19.841129] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 19.871219] tailscaled[618]: peerapi: serving on http://100.64.0.1:58436 hub # [ 19.873262] tailscaled[618]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 19.879255] tailscaled[618]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 19.881326] tailscaled[618]: netmap: suggested exit node: () hub # [ 19.885138] tailscaled[618]: writing netmap to disk cache hub # [ 19.889485] tailscaled[618]: health(warnable=no-derp-connection): ok hub # [ 19.897113] tailscaled[618]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 19.900248] tailscaled[618]: health(warnable=no-derp-connection): ok hub # [ 19.901756] tailscaled[618]: health(warnable=warming-up): ok hub # [ 19.903176] tailscaled[618]: [RATELIMIT] format("health(warnable=%s): ok") hub # [ 19.910205] nsncd[1025]: Jul 13 14:45:29.021 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 19.914969] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 19.918230] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 19.920112] systemd[1]: Reached target User and Group Name Lookups. hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-yAk4hGiQzepK-UXMElRv_eEhnnGN_NSRzOjsynyJEiACYBZ0OM9dPFJDetaURAhalrsfoSNKSJ0kI --hostname hub, in 2.92 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-yAk4hGiQzepK-UXMElRv_eEhnnGN_NSRzOjsynyJEiACYBZ0OM9dPFJDetaURAhalrsfoSNKSJ0kI --hostname tt-worker hub # [ 19.961667] headscale-start[873]: 2026-07-13T14:45:29Z INF http request bytes=0 elapsed=66.861012 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33458 status=200 worker # [ 16.493466] tailscaled[602]: localapi: [POST] /localapi/v0/check-prefs worker # [ 16.496067] tailscaled[602]: localapi: [POST] /localapi/v0/start worker # [ 16.498097] tailscaled[602]: Start worker # [ 16.501329] tailscaled[602]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="tt-worker" update=check Persist=nil}, reason: [opts.UpdatePrefs] worker # [ 16.509499] tailscaled[602]: generating new machine key worker # [ 16.514226] tailscaled[602]: machine key written to store worker # [ 16.515973] tailscaled[602]: profile data directory: profile not found worker # [ 16.518413] tailscaled[602]: Backend: logs: be:da95af73858721e27b9f43b99aae8d7246d809e1905f79727bb76e5b40132200 fe: worker # [ 16.523202] tailscaled[602]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 16.525809] tailscaled[602]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 16.528331] tailscaled[602]: blockEngineUpdates(true) worker # [ 16.530402] tailscaled[602]: Reconfig(down): no changes made to Engine config worker # [ 16.532992] tailscaled[602]: localapi: [POST] /localapi/v0/login-interactive worker # [ 16.535202] tailscaled[602]: StartLoginInteractiveAs("root"): url=false worker # [ 16.537436] tailscaled[602]: control: client.Login(2) worker # [ 16.540557] tailscaled[602]: control: client.Shutdown ... worker # [ 16.542341] tailscaled[602]: control: mapRoutine: exiting worker # [ 16.545116] tailscaled[602]: control: LoginInteractive -> regen=true worker # [ 16.547333] tailscaled[602]: control: doLogin(regen=true, hasUrl=false) worker # [ 16.549850] tailscaled[602]: health(warnable=wantrunning-false): ok worker # [ 16.551518] tailscaled[602]: control: authRoutine: exiting worker # [ 16.552980] tailscaled[602]: control: updateRoutine: exiting worker # [ 16.555336] tailscaled[602]: control: Client.Shutdown done. worker # [ 16.580089] tailscaled[602]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 20.074142] headscale-start[873]: 2026-07-13T14:45:29Z INF http request bytes=176 elapsed=0.221816 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:33484 status=200 worker # [ 16.596670] tailscaled[602]: control: control server key from https://hub: ts2021=[A4Rue], legacy= worker # [ 16.599440] tailscaled[602]: control: Generating a new nodekey. worker # [ 16.603763] tailscaled[602]: control: RegisterReq: onode= node=[dpPjj] fup=false nks=false hub # [ 20.158448] tailscaled[618]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 20.462455] headscale-start[873]: 2026-07-13T14:45:29Z INF http request bytes=0 elapsed=493.478082 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33458 status=200 hub # [ 20.734937] tailscaled[618]: netmap: suggested exit node: () hub # [ 20.745419] tailscaled[618]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 20.757282] tailscaled[618]: netmap: suggested exit node: () hub # [ 20.967777] headscale-start[873]: 2026-07-13T14:45:30Z INF http request bytes=0 elapsed=499.986172 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33458 status=200 worker # [ 17.496124] tailscaled[602]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 17.498925] tailscaled[602]: blockEngineUpdates(false) hub # [ 20.981497] headscale-start[873]: 2026-07-13T14:45:30Z INF http request bytes=248 elapsed=868.360643 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:33486 status=200 hub # [ 21.468703] headscale-start[873]: 2026-07-13T14:45:30Z INF http request bytes=0 elapsed=475.414613 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33486 status=200 hub # [ 21.538744] tailscaled[618]: netmap: suggested exit node: () hub # [ 21.559235] tailscaled[618]: netmap: suggested exit node: () hub # [ 21.562684] tailscaled[618]: [RATELIMIT] format("netmap: suggested exit node: %s (%s)") hub # [ 21.572959] tailscaled[618]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) hub # [ 21.577579] tailscaled[618]: wgengine: Reconfig: configuring router hub # [ 21.581303] tailscaled[618]: wgengine: Reconfig: user dialer hub # [ 21.584897] tailscaled[618]: tsdial: bart table size: 4 hub # [ 21.587580] tailscaled[618]: wgengine: Reconfig: configuring DNS hub # [ 21.590528] tailscaled[618]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} hub # [ 21.642610] tailscaled[618]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} hub # [ 21.644892] tailscaled[618]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 21.966436] headscale-start[873]: 2026-07-13T14:45:31Z INF node connected machine.key=[oM+MI] node.expired=false node.id=2 node.is_tagged=false node.key=[dpPjj] node.name=tt-worker node.online=true user.name=test hub # [ 21.978555] headscale-start[873]: 2026-07-13T14:45:31Z INF github.com/juanfont/headscale/hscontrol/poll.go:251 > node has connected chan=0xc28ca81dc00 component=poll machine.key=[oM+MI] node.expired=false node.id=2 node.is_tagged=false node.key=[dpPjj] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test worker # [ 18.533337] tailscaled[602]: health(warnable=not-in-map-poll): ok worker # [ 18.551962] tailscaled[602]: active login: test worker # [ 18.569638] tailscaled[602]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 18.576122] tailscaled[602]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 18.582505] tailscaled[602]: magicsock: SetPrivateKey called (init) worker # [ 18.587187] tailscaled[602]: wgengine: Reconfig: configuring userspace WireGuard config (with 1 peers) worker # [ 18.592101] tailscaled[602]: wgengine: Reconfig: configuring router worker # [ 18.711581] tailscaled[602]: router: enabling connmark-based rp_filter workaround worker # [ 18.735668] tailscaled[602]: wgengine: Reconfig: user dialer worker # [ 18.737129] tailscaled[602]: tsdial: bart table size: 4 worker # [ 18.738446] tailscaled[602]: wgengine: Reconfig: configuring DNS worker # [ 18.739911] tailscaled[602]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:2} worker # [ 18.756881] tailscaled[602]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:2 LocalDomains:[tailnet.]+65arpa} worker # [ 18.759297] tailscaled[602]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 18.801953] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 18.804310] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 18.808568] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 18.810225] systemd[1]: Stopping User and Group Name Lookups... worker # [ 18.811744] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 18.814430] systemd[1]: nscd.service: Deactivated successfully. worker # [ 18.817330] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 18.819234] tailscaled[602]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [12ms] (forced=false) worker # [ 18.822152] tailscaled[602]: magicsock: home is now derp-999 () worker # [ 18.826294] tailscaled[602]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 18.828212] tailscaled[602]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 18.829927] tailscaled[602]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 18.835107] tailscaled[602]: magicsock: endpoints changed: 192.168.1.2:41641 (stun), [2001:db8:1::2]:41641 (stun), 10.0.2.15:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::ff5d:548a:fda7:4253]:41641 (local) worker # [ 18.843592] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 18.847862] tailscaled[602]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 18.867642] tailscaled[602]: magicsock: derp-999 connected; connGen=1 worker # [ 18.875106] tailscaled[602]: peerapi: serving on http://100.64.0.2:46590 worker # [ 18.876721] tailscaled[602]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 18.880211] tailscaled[602]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 18.883631] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 18.886253] tailscaled[602]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 18.890930] nsncd[922]: Jul 13 14:45:31.791 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 18.895742] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 18.897828] systemd[1]: Reached target User and Group Name Lookups. worker # [ 18.902331] tailscaled[602]: netmap: suggested exit node: () worker # [ 18.906200] tailscaled[602]: writing netmap to disk cache worker # [ 18.909628] tailscaled[602]: health(warnable=no-derp-connection): ok worker # [ 18.911964] tailscaled[602]: health(warnable=no-derp-connection): ok worker # [ 18.913853] tailscaled[602]: health(warnable=no-derp-connection): ok worker # [ 18.915674] tailscaled[602]: [RATELIMIT] format("health(warnable=%s): ok") worker # [ 18.921731] tailscaled[602]: netcheck: netcheck: DNS lookup error for "hub" (node "999" region 999): context canceled worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-yAk4hGiQzepK-UXMElRv_eEhnnGN_NSRzOjsynyJEiACYBZ0OM9dPFJDetaURAhalrsfoSNKSJ0kI --hostname tt-worker, in 2.49 seconds) worker # [ 18.924327] tailscaled[602]: netcheck: netcheck.runProbe: named node "999" has no v4 address worker: waiting for success: tailscale ping hub worker # [ 18.951135] tailscaled[602]: localapi: [POST] /localapi/v0/ping worker # [ 18.952662] tailscaled[602]: ping(100.64.0.1): sending disco ping to [ly23T] hub ... worker # [ 18.962408] tailscaled[602]: magicsock: disco: node [ly23T] d:51eb17f52354aae5 now using 192.168.1.1:41641 mtu=1360 tx=3210ef690ff6 worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds) hub: must succeed: tailscale ip -4 hub # [ 22.476656] headscale-start[873]: 2026-07-13T14:45:31Z INF http request bytes=0 elapsed=84.288925 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33486 status=200 hub: (finished: must succeed: tailscale ip -4, in 0.08 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: (finished: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml, in 0.03 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 22.608147] systemd[1]: Starting tribuchet-hub.socket... hub # [ 22.618783] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 22.623838] systemd[1]: Starting tribuchet-hub.service... hub # [ 22.705047] tribuchet[1067]: 2026-07-13T14:45:31.816094Z INFO tribuchet::hub: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 22.710692] tribuchet[1067]: 2026-07-13T14:45:31.823909Z WARN tribuchet::hub: no trusted-signing-keys file in /etc/tribuchet; accepting any signing key from transport-authenticated workers hub # [ 22.715800] tribuchet[1067]: 2026-07-13T14:45:31.828785Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 22.723823] tribuchet[1067]: 2026-07-13T14:45:31.837133Z INFO tribuchet::hub: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 22.728387] systemd[1]: Started tribuchet-hub.service. hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.17 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 19.308448] systemd[1]: Starting tribuchet-worker.service... worker # [ 19.410527] exec[963]: 2026-07-13T14:45:32.312447Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false } worker # [ 19.422621] exec[963]: 2026-07-13T14:45:32.325279Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service worker # [ 19.430276] exec[966]: 2026-07-13T14:45:32.332029Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false } worker # [ 19.444508] exec[966]: 2026-07-13T14:45:32.347258Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 19.452372] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.21 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' hub # [ 22.976391] tailscaled[618]: magicsock: disco: node [dpPjj] d:6e6961cbbd9de288 now using 192.168.1.2:41641 mtu=1360 tx=4bab943a08f6 hub # [ 22.996127] headscale-start[873]: 2026-07-13T14:45:32Z INF http request bytes=0 elapsed=502.682324 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:33486 status=200 hub # [ 23.043875] tribuchet[1067]: 2026-07-13T14:45:32.157205Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }] hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 0.11 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.02 seconds) hub: must succeed: nix-store --add /root/payload worker # [ 19.587343] exec[966]: 2026-07-13T14:45:32.489450Z INFO tribuchet::worker: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] worker # [ 19.646806] tailscaled[602]: netmap: suggested exit node: () worker # [ 19.652409] tailscaled[602]: [RATELIMIT] format("control: [v\x00JSON]%d%s") worker # [ 19.655753] tailscaled[602]: netmap: suggested exit node: () hub: (finished: must succeed: nix-store --add /root/payload, in 0.13 seconds) hub: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9"; 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/bbzjxfam8vv1nyikn5dsrazsw4ya5vzx-bash-interactive-5.3p9"; 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.03 seconds) hub: must succeed: nix-build /root/test.nix --no-out-link hub # this derivation will be built: hub # /nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv hub # building '/nix/store/0mrv96b259ksy183vx3z6xa1rvzvxsfh-tt-tailscale.drv'... hub # [ 23.505066] tribuchet[1067]: 2026-07-13T14:45:32.618496Z INFO tribuchet::hub::submit: queueing build id="f0f33ebf3ccf55449d8624696c011a57" system="x86_64-linux" hub # [ 23.510114] tribuchet[1067]: 2026-07-13T14:45:32.623509Z INFO tribuchet::hub: dispatching build id="f0f33ebf3ccf55449d8624696c011a57" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 20.032833] exec[966]: 2026-07-13T14:45:32.933404Z INFO tribuchet::worker: build assigned id="f0f33ebf3ccf55449d8624696c011a57" worker # [ 20.048728] systemd[1]: Started Nix Daemon. worker # [ 20.112642] nix-daemon[968]: accepted connection from pid 966, user tribuchet (trusted) worker # [ 20.119972] exec[966]: 2026-07-13T14:45:33.022688Z INFO harmonia_store_remote::client: Client Version is 1.38, server version is 1.38 version=ProtocolVersion(1, 38) server_version=ProtocolVersion(1, 38) features={} worker # [ 20.125752] exec[966]: 2026-07-13T14:45:33.028221Z INFO harmonia_store_remote::client: Nix Version "2.34.8" version="2.34.8" hub # [ 23.618943] tribuchet[1067]: 2026-07-13T14:45:32.732129Z INFO tribuchet::hub::relay: input path negotiation done id="f0f33ebf3ccf55449d8624696c011a57" total=8 missing=1 hub # [ 23.629385] systemd[1]: Started Nix Daemon. hub # [ 23.726595] nix-daemon[1098]: accepted connection from pid 1067, user root (trusted) hub # [ 23.734488] tribuchet[1067]: 2026-07-13T14:45:32.847410Z INFO harmonia_store_remote::client: Client Version is 1.38, server version is 1.38 version=ProtocolVersion(1, 38) server_version=ProtocolVersion(1, 38) features={} hub # [ 23.740766] tribuchet[1067]: 2026-07-13T14:45:32.847802Z INFO harmonia_store_remote::client: Nix Version "2.34.8+2" version="2.34.8+2" worker # [ 20.320447] exec[966]: 2026-07-13T14:45:33.222116Z INFO tribuchet::worker::build: sandbox network decision id="f0f33ebf3ccf55449d8624696c011a57" fixed_output=false network=false net_isolation=false worker # [ 20.349327] systemd[1]: Starting tribuchet-sandboxd.service... worker # [ 20.387090] systemd[1]: Started tribuchet-sandboxd.service. worker # [ 20.389876] tribuchet-sandboxd[976]: 2026-07-13T14:45:33.292316Z INFO tribuchet_sandboxd: listening socket=/run/tribuchet-sandboxd.sock worker # [ 20.395984] exec[966]: 2026-07-13T14:45:33.298141Z INFO tribuchet::worker::build: leased sandbox build_id="f0f33ebf3ccf55449d8624696c011a57" pool_base=1325400064 uid_count=1 worker # [ 20.401088] tribuchet-sandboxd[976]: 2026-07-13T14:45:33.303765Z INFO tribuchet_sandboxd: leased build="f0f33ebf3ccf55449d8624696c011a57" base=1325400064 uid_count=1 worker # [ 20.602348] tribuchet-sandboxd[976]: 2026-07-13T14:45:33.504711Z INFO tribuchet_sandboxd: released build="f0f33ebf3ccf55449d8624696c011a57" base=1325400064 worker # [ 20.615365] exec[966]: 2026-07-13T14:45:33.515516Z INFO tribuchet::worker::build: builder finished id="f0f33ebf3ccf55449d8624696c011a57" exit_code=0 worker # [ 20.641979] exec[966]: 2026-07-13T14:45:33.544548Z INFO tribuchet::worker::resume: build result sent, awaiting ack id="f0f33ebf3ccf55449d8624696c011a57" worker # [ 20.659942] exec[966]: 2026-07-13T14:45:33.562633Z INFO tribuchet::worker::resume: build result acknowledged id="f0f33ebf3ccf55449d8624696c011a57" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 0.94 seconds) hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-tt-tailscale hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/wfhw3b9xryfvhk6h35sks1na44nfv6qc-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.04 seconds) (finished: subtest: a build dispatches over the tailnet, in 1.22 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.02 seconds) worker: must succeed: systemctl restart tribuchet-worker worker # [ 20.828472] exec[966]: 2026-07-13T14:45:33.731103Z INFO tribuchet::worker: handover requested; exiting worker # [ 20.833308] systemd[1]: Stopping tribuchet-worker.service... hub # [ 24.325132] tribuchet[1067]: 2026-07-13T14:45:33.438456Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 21.035936] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 21.045611] systemd[1]: Stopped tribuchet-worker.service. worker # [ 21.051212] systemd[1]: tribuchet-worker.service: Consumed 94ms CPU time over 1.735s wall clock time, 18M memory peak, 14.3M read from disk, 4K written to disk, 3.9K incoming IP traffic, 2.1K outgoing IP traffic. worker # [ 21.076931] systemd[1]: Starting tribuchet-worker.service... worker # [ 21.128246] exec[1000]: 2026-07-13T14:45:34.030254Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false } worker # [ 21.139369] exec[1000]: 2026-07-13T14:45:34.042031Z INFO tribuchet::worker::cgroup: per-build cgroup scoping enabled base=/sys/fs/cgroup/system.slice/tribuchet-worker.service worker # [ 21.145318] exec[1003]: 2026-07-13T14:45:34.047791Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false } worker # [ 21.156339] exec[1003]: 2026-07-13T14:45:34.059101Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/zrynrzpsy2993w555ns9a734lbzfff2b-busybox-1.37.0/bin/busybox") worker # [ 21.164103] systemd[1]: Started tribuchet-worker.service. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.36 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' hub # [ 25.033202] tribuchet[1067]: 2026-07-13T14:45:34.144524Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:35308 worker # [ 21.546565] exec[1003]: 2026-07-13T14:45:34.449117Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 21.558322] exec[1003]: 2026-07-13T14:45:34.449206Z INFO tribuchet::worker: reconnecting to hub in 1s worker # [ 21.957441] tailscaled[602]: magicsock: disco: node [ly23T] d:51eb17f52354aae5 now using [2001:db8:1::1]:41641 mtu=1360 tx=b218669e51f9 hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.14 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.51 seconds) (finished: run the VM test script, in 26.92 seconds) test script finished in 27.00s cleanup kill QemuMachine (pid 48) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14) kill QemuMachine (pid 47) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/jxyrvv4gbpnp3ap5iy7wxwl1sg4x2x88-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.36 seconds) 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