vm-test-run-tribuchet-tailscale
checks.x86_64-linux.nixos-test-tailscale
· build #330
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 hub, worker,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11hub: starting vm12worker: starting vm13hub # Disk image does not exist, creating the virtualisation disk image...14hub # Formatting '/build/vm-state-hub/tmp.11P1Ot8JzB', fmt=raw size=107374182415hub # mke2fs 1.47.4 (6-Mar-2025)16hub # Discarding device blocks: 0/262144 done17hub # Creating filesystem with 262144 4k blocks and 65536 inodes18hub: QEMU running (pid 48)19hub # Filesystem UUID: 6667df2e-e7b5-43b3-8d47-cd1d8d5ef89820hub # Superblock backups stored on blocks:21hub # 32768, 98304, 163840, 22937622hub # 23hub # Allocating group tables: 0/8 done24hub # Writing inode tables: 0/8 done25hub # Creating journal (8192 blocks): done26hub # Writing superblocks and filesystem accounting information: 0/8 done27hub # 28hub # Virtualisation disk image created.29hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)30hub # 31hub # 32hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC730+7EF2C730 CA0033hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)...34hub # 35hub # 36hub # 37hub # 38hub # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC730 7EF2C730 CB0039hub # Press Ctrl-B to configure iPXE (PCI 00:08.0)...40hub # 41hub # 42hub # Booting from ROM...43hub # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 202644hub # [ 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/za7cpnjid60r6wib33fzdwvm341yamj9-nixos-system-hub-test/init regInfo=/nix/store/p0zxxmz3jvpdywa431irg7fi5yj5lxnv-closure-info/registration console=ttyS0,115200n8 console=tty045hub # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees.46hub # [ 0.000000] BIOS-provided physical RAM map:47hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable48hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved49hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved50hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable51hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved52hub # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved53hub # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved54hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved55hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved56hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved57hub # [ 0.000000] NX (Execute Disable) protection: active58hub # [ 0.000000] APIC: Static calls initialized59hub # [ 0.000000] SMBIOS 2.8 present.60hub # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201461hub # [ 0.000000] DMI: Memory slots populated: 1/162hub # [ 0.000000] Hypervisor detected: KVM63hub # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x40000000064hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0065hub # [ 0.000001] kvm-clock: using sched offset of 570631563 cycles66hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns67hub # [ 0.000006] tsc: Detected 3099.998 MHz processor68hub # [ 0.000742] last_pfn = 0x7ffd8 max_arch_pfn = 0x40000000069hub # [ 0.000769] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs70hub # [ 0.000772] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT71hub # [ 0.002802] found SMP MP-table at [mem 0x000f5450-0x000f545f]72hub # [ 0.002815] Using GB pages for direct mapping73hub # [ 0.002965] RAMDISK: [mem 0x7e369000-0x7ffcffff]74hub # [ 0.002972] ACPI: Early table checksum verification disabled75hub # [ 0.002975] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )76hub # [ 0.002979] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)77hub # [ 0.002984] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)78hub # [ 0.002990] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)79hub # [ 0.002992] ACPI: FACS 0x000000007FFE0000 00004080hub # [ 0.002995] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)81hub # [ 0.002997] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)82hub # [ 0.002999] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)83hub # [ 0.003001] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)84hub # [ 0.003002] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d]85hub # [ 0.003003] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219]86hub # [ 0.003004] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]87hub # [ 0.003005] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385]88hub # [ 0.003005] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd]89hub # [ 0.003006] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9]90hub # [ 0.003006] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421]91hub # [ 0.003391] No NUMA configuration found92hub # [ 0.003392] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]93hub # [ 0.003395] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]94hub # [ 0.003476] Zone ranges:95hub # [ 0.003477] DMA [mem 0x0000000000001000-0x0000000000ffffff]96hub # [ 0.003478] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff]97hub # [ 0.003480] Normal empty98hub # [ 0.003480] Device empty99hub # [ 0.003481] Movable zone start for each node100hub # [ 0.003481] Early memory node ranges101hub # [ 0.003482] node 0: [mem 0x0000000000001000-0x000000000009efff]102hub # [ 0.003483] node 0: [mem 0x0000000000100000-0x000000007ffd7fff]103hub # [ 0.003484] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]104hub # [ 0.003503] On node 0, zone DMA: 1 pages in unavailable ranges105hub # [ 0.003745] On node 0, zone DMA: 97 pages in unavailable ranges106hub # [ 0.037070] On node 0, zone DMA32: 40 pages in unavailable ranges107hub # [ 0.037968] ACPI: PM-Timer IO Port: 0x608108hub # [ 0.037984] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])109hub # [ 0.038013] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23110hub # [ 0.038016] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)111hub # [ 0.038018] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)112hub # [ 0.038019] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)113hub # [ 0.038020] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)114hub # [ 0.038020] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)115hub # [ 0.038024] ACPI: Using ACPI (MADT) for SMP configuration information116hub # [ 0.038025] ACPI: HPET id: 0x8086a201 base: 0xfed00000117hub # [ 0.038031] TSC deadline timer available118hub # [ 0.038036] CPU topo: Max. logical packages: 1119hub # [ 0.038037] CPU topo: Max. logical dies: 1120hub # [ 0.038037] CPU topo: Max. dies per package: 1121hub # [ 0.038040] CPU topo: Max. threads per core: 1122hub # [ 0.038041] CPU topo: Num. cores per package: 1123hub # [ 0.038042] CPU topo: Num. threads per package: 1124hub # [ 0.038042] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs125hub # [ 0.038061] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()126hub # [ 0.038097] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]127hub # [ 0.038098] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]128hub # [ 0.038100] [mem 0xc0000000-0xfed1bfff] available for PCI devices129hub # [ 0.038102] Booting paravirtualized kernel on KVM130hub # [ 0.038105] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns131hub # [ 0.042573] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1132hub # [ 0.045032] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152133hub # [ 0.045079] kvm-guest: PV spinlocks disabled, single CPU134hub # [ 0.045080] 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/za7cpnjid60r6wib33fzdwvm341yamj9-nixos-system-hub-test/init regInfo=/nix/store/p0zxxmz3jvpdywa431irg7fi5yj5lxnv-closure-info/registration console=ttyS0,115200n8 console=tty0135hub # [ 0.045176] Unknown kernel command line parameters "regInfo=/nix/store/p0zxxmz3jvpdywa431irg7fi5yj5lxnv-closure-info/registration", will be passed to user space.136hub # [ 0.045195] random: crng init done137hub # [ 0.045195] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes138hub # [ 0.047234] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)139hub # [ 0.048249] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)140hub # [ 0.048281] Fallback order for Node 0: 0141hub # [ 0.048284] Built 1 zonelists, mobility grouping on. Total pages: 524150142hub # [ 0.048285] Policy zone: DMA32143hub # [ 0.050604] mem auto-init: stack:all(zero), heap alloc:on, heap free:off144hub # [ 0.056994] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1145hub # [ 0.061523] allocated 4194304 bytes of page_ext146hub # [ 0.070221] ftrace: allocating 48733 entries in 192 pages147hub # [ 0.070224] ftrace: allocated 192 pages with 2 groups148hub # [ 0.071088] Dynamic Preempt: lazy149hub # [ 0.071242] rcu: Preemptible hierarchical RCU implementation.150hub # [ 0.071242] rcu: RCU event tracing is enabled.151hub # [ 0.071243] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.152hub # [ 0.071244] Trampoline variant of Tasks RCU enabled.153hub # [ 0.071244] Rude variant of Tasks RCU enabled.154hub # [ 0.071245] Tracing variant of Tasks RCU enabled.155hub # [ 0.071245] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.156hub # [ 0.071246] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1157hub # [ 0.071302] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.158hub # [ 0.071303] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.159hub # [ 0.071304] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.160hub # [ 0.076193] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16161hub # [ 0.076497] rcu: srcu_init: Setting srcu_struct sizes based on contention.162hub # [ 0.076508] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns163hub # [ 0.076625] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)164hub # [ 0.082851] Console: colour VGA+ 80x25165hub # [ 0.082858] printk: legacy console [tty0] enabled166hub # [ 0.120660] printk: legacy console [ttyS0] enabled167hub # [ 0.278572] ACPI: Core revision 20250807168hub # [ 0.279775] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns169hub # [ 0.281949] APIC: Switch to symmetric I/O mode setup170hub # [ 0.283276] x2apic enabled171hub # [ 0.284280] APIC: Switched APIC routing to: physical x2apic172hub # [ 0.286558] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1173hub # [ 0.288023] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns174hub # [ 0.290383] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998)175hub # [ 0.291474] x86/cpu: User Mode Instruction Prevention (UMIP) activated176hub # [ 0.292534] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127177hub # [ 0.293381] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0178hub # [ 0.294399] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto179hub # [ 0.295386] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl180hub # [ 0.297381] Spectre V2 : Mitigation: Retpolines181hub # [ 0.299193] RETBleed: Mitigation: untrained return thunk182hub # [ 0.300381] Speculative Return Stack Overflow: Mitigation: SMT disabled183hub # [ 0.302381] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization184hub # [ 0.304382] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT185hub # [ 0.306381] Spectre V2 : Enabling Speculation Barrier for firmware calls186hub # [ 0.307381] active return thunk: retbleed_return_thunk187hub # [ 0.308387] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier188hub # [ 0.309396] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'189hub # [ 0.310381] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'190hub # [ 0.311381] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'191hub # [ 0.312382] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256192hub # [ 0.313381] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.193hub # [ 0.340262] Freeing SMP alternatives memory: 44K194hub # [ 0.341387] pid_max: default: 32768 minimum: 301195hub # [ 0.342540] LSM: initializing lsm=capability,landlock,yama,bpf,ima196hub # [ 0.344533] landlock: Up and running.197hub # [ 0.345385] Yama: becoming mindful.198hub # [ 0.346948] LSM support for eBPF active199hub # [ 0.348545] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)200hub # [ 0.349421] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)201hub # [ 0.351800] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0)202hub # [ 0.352944] Performance Events: Fam17h+ core perfctr, AMD PMU driver.203hub # [ 0.353389] ... version: 0204hub # [ 0.354383] ... bit width: 48205hub # [ 0.355382] ... generic counters: 6206hub # [ 0.356382] ... generic bitmap: 000000000000003f207hub # [ 0.357383] ... fixed-purpose counters: 0208hub # [ 0.358382] ... fixed-purpose bitmap: 0000000000000000209hub # [ 0.359382] ... value mask: 0000ffffffffffff210hub # [ 0.360382] ... max period: 00007fffffffffff211hub # [ 0.361383] ... global_ctrl mask: 000000000000003f212hub # [ 0.362541] signal: max sigframe size: 1776213hub # [ 0.363519] rcu: Hierarchical SRCU implementation.214hub # [ 0.364387] rcu: Max phase no-delay instances is 400.215hub # [ 0.368974] smp: Bringing up secondary CPUs ...216hub # [ 0.369399] smp: Brought up 1 node, 1 CPU217hub # [ 0.370389] smpboot: Total of 1 processors activated (6199.99 BogoMIPS)218hub # [ 0.371580] Memory: 1971600K/2096600K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115512K reserved, 0K cma-reserved)219hub # [ 0.373930] devtmpfs: initialized220hub # [ 0.374611] x86/mm: Memory block size: 128MB221hub # [ 0.376324] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)222hub # [ 0.377419] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).223hub # [ 0.378501] pinctrl core: initialized pinctrl subsystem224hub # [ 0.379681] PM: RTC time: 15:05:28, date: 2026-10-06225hub # [ 0.383372] NET: Registered PF_NETLINK/PF_ROUTE protocol family226hub # [ 0.384879] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations227hub # [ 0.385449] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations228hub # [ 0.386688] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations229hub # [ 0.387424] audit: initializing netlink subsys (disabled)230hub # [ 0.388795] thermal_sys: Registered thermal governor 'fair_share'231hub # [ 0.388797] thermal_sys: Registered thermal governor 'bang_bang'232hub # [ 0.389384] thermal_sys: Registered thermal governor 'step_wise'233hub # [ 0.390388] audit: type=2000 audit(1791299128.755:1): state=initialized audit_enabled=0 res=1234hub # [ 0.392394] thermal_sys: Registered thermal governor 'user_space'235hub # [ 0.392398] thermal_sys: Registered thermal governor 'power_allocator'236hub # [ 0.393468] cpuidle: using governor menu237hub # [ 0.396500] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5238hub # [ 0.397767] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]239hub # [ 0.398392] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry240hub # [ 0.399410] PCI: Using configuration type 1 for base access241hub # [ 0.400828] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.242hub # [ 0.405853] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages243hub # [ 0.406455] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page244hub # [ 0.407390] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages245hub # [ 0.414386] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page246hub # [ 0.423971] ACPI: Added _OSI(Module Device)247hub # [ 0.424392] ACPI: Added _OSI(Processor Device)248hub # [ 0.429382] ACPI: Added _OSI(Processor Aggregator Device)249hub # [ 0.435922] ACPI: 1 ACPI AML tables successfully acquired and loaded250hub # [ 0.440085] ACPI: Interpreter enabled251hub # [ 0.440409] ACPI: PM: (supports S0 S3 S4 S5)252hub # [ 0.441389] ACPI: Using IOAPIC for interrupt routing253hub # [ 0.444446] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug254hub # [ 0.445383] PCI: Using E820 reservations for host bridge windows255hub # [ 0.448554] ACPI: Enabled 2 GPEs in block 00 to 3F256hub # [ 0.457045] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])257hub # [ 0.457389] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]258hub # [ 0.458465] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]259hub # [ 0.459482] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]260hub # [ 0.460904] PCI host bridge to bus 0000:00261hub # [ 0.461390] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]262hub # [ 0.462385] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]263hub # [ 0.463385] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]264hub # [ 0.464385] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]265hub # [ 0.465384] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]266hub # [ 0.466384] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]267hub # [ 0.467384] pci_bus 0000:00: root bus resource [bus 00-ff]268hub # [ 0.468556] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint269hub # [ 0.470186] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint270hub # [ 0.473449] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]271hub # [ 0.474410] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]272hub # [ 0.475432] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]273hub # [ 0.476581] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]274hub # [ 0.478319] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint275hub # [ 0.481404] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]276hub # [ 0.482394] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]277hub # [ 0.483432] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]278hub # [ 0.484396] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]279hub # [ 0.486394] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint280hub # [ 0.489317] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]281hub # [ 0.490340] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]282hub # [ 0.491430] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]283hub # [ 0.493364] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint284hub # [ 0.496122] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]285hub # [ 0.497352] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]286hub # [ 0.498431] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]287hub # [ 0.501025] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint288hub # [ 0.504425] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]289hub # [ 0.505426] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]290hub # [ 0.506438] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]291hub # [ 0.508993] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint292hub # [ 0.512418] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]293hub # [ 0.513400] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]294hub # [ 0.514440] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]295hub # [ 0.518000] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint296hub # [ 0.521472] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]297hub # [ 0.522409] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]298hub # [ 0.524523] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]299hub # [ 0.526743] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint300hub # [ 0.529424] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]301hub # [ 0.530412] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]302hub # [ 0.531439] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]303hub # [ 0.533407] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]304hub # [ 0.535929] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint305hub # [ 0.539148] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]306hub # [ 0.540434] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]307hub # [ 0.542691] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint308hub # [ 0.545418] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]309hub # [ 0.546398] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]310hub # [ 0.547435] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]311hub # [ 0.549466] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint312hub # [ 0.552410] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]313hub # [ 0.553402] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]314hub # [ 0.554447] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]315hub # [ 0.556610] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint316hub # [ 0.558472] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]317hub # [ 0.559899] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint318hub # [ 0.561863] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]319hub # [ 0.562754] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint320hub # [ 0.565356] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]321hub # [ 0.566792] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint322hub # [ 0.568400] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]323hub # [ 0.570811] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint324hub # [ 0.571986] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO325hub # [ 0.573887] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint326hub # [ 0.577443] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]327hub # [ 0.578396] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]328hub # [ 0.580005] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint329hub # [ 0.582461] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]330hub # [ 0.589081] ACPI: PCI: Interrupt link LNKA configured for IRQ 10331hub # [ 0.590529] ACPI: PCI: Interrupt link LNKB configured for IRQ 10332hub # [ 0.591549] ACPI: PCI: Interrupt link LNKC configured for IRQ 11333hub # [ 0.592672] ACPI: PCI: Interrupt link LNKD configured for IRQ 11334hub # [ 0.593556] ACPI: PCI: Interrupt link LNKE configured for IRQ 10335hub # [ 0.594551] ACPI: PCI: Interrupt link LNKF configured for IRQ 10336hub # [ 0.595502] ACPI: PCI: Interrupt link LNKG configured for IRQ 11337hub # [ 0.596507] ACPI: PCI: Interrupt link LNKH configured for IRQ 11338hub # [ 0.597433] ACPI: PCI: Interrupt link GSIA configured for IRQ 16339hub # [ 0.598401] ACPI: PCI: Interrupt link GSIB configured for IRQ 17340hub # [ 0.599441] ACPI: PCI: Interrupt link GSIC configured for IRQ 18341hub # [ 0.600403] ACPI: PCI: Interrupt link GSID configured for IRQ 19342hub # [ 0.601411] ACPI: PCI: Interrupt link GSIE configured for IRQ 20343hub # [ 0.602402] ACPI: PCI: Interrupt link GSIF configured for IRQ 21344hub # [ 0.603404] ACPI: PCI: Interrupt link GSIG configured for IRQ 22345hub # [ 0.604455] ACPI: PCI: Interrupt link GSIH configured for IRQ 23346hub # [ 0.606580] iommu: Default domain type: Translated347hub # [ 0.607393] iommu: DMA domain TLB invalidation policy: lazy mode348hub # [ 0.608757] ACPI: bus type USB registered349hub # [ 0.609469] usbcore: registered new interface driver usbfs350hub # [ 0.610402] usbcore: registered new interface driver hub351hub # [ 0.611413] usbcore: registered new device driver usb352hub # [ 0.613279] NetLabel: Initializing353hub # [ 0.614063] NetLabel: domain hash size = 128354hub # [ 0.614383] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO355hub # [ 0.615472] NetLabel: unlabeled traffic allowed by default356hub # [ 0.616395] PCI: Using ACPI for IRQ routing357hub # [ 0.706561] pci 0000:00:01.0: vgaarb: setting as boot VGA device358hub # [ 0.707378] pci 0000:00:01.0: vgaarb: bridge control possible359hub # [ 0.707378] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none360hub # [ 0.707457] vgaarb: loaded361hub # [ 0.708456] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0362hub # [ 0.709392] hpet0: 3 comparators, 64-bit 100.000000 MHz counter363hub # [ 0.715505] clocksource: Switched to clocksource kvm-clock364hub # [ 0.717794] VFS: Disk quotas dquot_6.6.0365hub # [ 0.720313] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)366hub # [ 0.722246] pnp: PnP ACPI init367hub # [ 0.723337] ACPI: IRQ 4 override to edge(!), high(!)368hub # [ 0.724780] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved369hub # [ 0.727006] pnp: PnP ACPI: found 6 devices370hub # [ 0.734376] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns371hub # [ 0.736607] clocksource: Switched to clocksource acpi_pm372hub # [ 0.738205] NET: Registered PF_INET protocol family373hub # [ 0.739959] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)374hub # [ 0.757059] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)375hub # [ 0.759300] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)376hub # [ 0.761195] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)377hub # [ 0.763247] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)378hub # [ 0.765248] TCP: Hash tables configured (established 16384 bind 16384)379hub # [ 0.767093] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)380hub # [ 0.769047] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)381hub # [ 0.770750] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)382hub # [ 0.772617] NET: Registered PF_UNIX/PF_LOCAL protocol family383hub # [ 0.774139] NET: Registered PF_XDP protocol family384hub # [ 0.775335] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]385hub # [ 0.777717] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]386hub # [ 0.779266] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]387hub # [ 0.781007] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]388hub # [ 0.782672] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]389hub # [ 0.784345] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]390hub # [ 0.786654] ACPI: \_SB_.GSIA: Enabled at IRQ 16391hub # [ 0.788923] ACPI: \_SB_.GSIB: Enabled at IRQ 17392hub # [ 0.791056] ACPI: \_SB_.GSIC: Enabled at IRQ 18393hub # [ 0.793211] ACPI: \_SB_.GSID: Enabled at IRQ 19394hub # [ 0.795406] PCI: CLS 0 bytes, default 64395hub # [ 0.796711] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns396hub # [ 0.799967] Trying to unpack rootfs image as initramfs...397hub # [ 0.875276] Initialise system trusted keyrings398hub # [ 0.876683] workingset: timestamp_bits=40 max_order=19 bucket_order=0399hub # [ 0.901023] Key type asymmetric registered400hub # [ 0.902226] Asymmetric key parser 'x509' registered401hub # [ 0.905977] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)402hub # [ 0.911981] io scheduler mq-deadline registered403hub # [ 0.913093] io scheduler kyber registered404hub # [ 0.916500] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled405hub # [ 0.920954] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A406hub # [ 0.928731] Linux agpgart interface v0.103407hub # [ 0.931983] ACPI: bus type drm_connector registered408hub # [ 0.933848] usbcore: registered new interface driver usbserial_generic409hub # [ 0.935506] usbserial: USB Serial support registered for generic410hub # [ 0.941930] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled411hub # [ 0.947067] drop_monitor: Initializing network drop monitor service412hub # [ 0.948685] NET: Registered PF_INET6 protocol family413hub # [ 0.952506] Segment Routing with IPv6414hub # [ 0.954932] In-situ OAM (IOAM) with IPv6415hub # [ 0.958162] IPI shorthand broadcast: enabled416hub # [ 0.963124] sched_clock: Marking stable (754024241, 208871439)->(1144286749, -181391069)417hub # [ 0.969301] registered taskstats version 1418hub # [ 0.970591] Loading compiled-in X.509 certificates419hub # [ 0.982098] Demotion targets for Node 0: null420hub # [ 0.985962] Key type .fscrypt registered421hub # [ 0.986968] Key type fscrypt-provisioning registered422hub # [ 0.990025] ima: No TPM chip found, activating TPM-bypass!423hub # [ 0.991446] ima: Allocated hash algorithm: sha1424hub # [ 0.995971] ima: No architecture policies found425hub # [ 0.998917] PM: Magic number: 14:578:82426hub # [ 1.000844] RAS: Correctable Errors collector initialized.427hub # [ 1.010824] clk: Disabling unused clocks428hub # [ 1.015914] PM: genpd: Disabling unused power domains429hub # [ 1.273066] Freeing initrd memory: 29084K430hub # [ 1.277851] Freeing unused decrypted memory: 2028K431hub # [ 1.281101] Freeing unused kernel image (initmem) memory: 3644K432hub # [ 1.282744] Write protecting the kernel read-only data: 32768k433hub # [ 1.285172] Freeing unused kernel image (text/rodata gap) memory: 1216K434hub # [ 1.287412] Freeing unused kernel image (rodata/data gap) memory: 756K435hub # [ 1.333011] x86/mm: Checked W+X mappings: passed, no W+X pages found.436hub # [ 1.334781] Run /init as init process437hub # [ 1.344829] systemd[1]: Inserted module 'autofs4'438hub # [ 1.362266] fuse: init (API version 7.45)439hub # [ 1.368499] ACPI: \_SB_.GSIG: Enabled at IRQ 22440hub # [ 1.371686] ACPI: \_SB_.GSIH: Enabled at IRQ 23441hub # [ 1.376582] ACPI: \_SB_.GSIE: Enabled at IRQ 20442hub # [ 1.379609] ACPI: \_SB_.GSIF: Enabled at IRQ 21443hub # [ 1.412329] systemd[1]: Successfully made /usr/ read-only.444hub # [ 1.748809] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)445hub # [ 1.756301] systemd[1]: Detected virtualization kvm.446hub # [ 1.757671] systemd[1]: Detected architecture x86-64.447hub # [ 1.759110] systemd[1]: Running in initrd.448hub # [ 1.760627] systemd[1]: Initializing machine ID from random generator.449hub # [ 1.762500] systemd[1]: Hostname set to <hub>.450hub # [ 1.945223] systemd[1]: bpf-restrict-fs: LSM BPF program attached451hub # [ 2.000717] systemd[1]: Queued start job for default target Initrd Default Target.452hub # [ 2.005568] systemd[1]: Created slice Slice /system/modprobe.453hub # [ 2.007395] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.454hub # [ 2.009511] systemd[1]: Expecting device /dev/disk/by-label/nixos...455hub # [ 2.011259] systemd[1]: Reached target Path Units.456hub # [ 2.012674] systemd[1]: Reached target Slice Units.457hub # [ 2.014359] systemd[1]: Reached target Swaps.458hub # [ 2.016291] systemd[1]: Reached target Timer Units.459hub # [ 2.018445] systemd[1]: Listening on D-Bus System Message Bus Socket.460hub # [ 2.020423] systemd[1]: Listening on Journal Socket (/dev/log).461hub # [ 2.022325] systemd[1]: Listening on Journal Sockets.462hub # [ 2.024298] systemd[1]: Listening on udev Control Socket.463hub # [ 2.026130] systemd[1]: Listening on udev Kernel Socket.464hub # [ 2.027908] systemd[1]: Reached target Socket Units.465hub # [ 2.030798] systemd[1]: Starting Create List of Static Device Nodes...466hub # [ 2.040461] systemd[1]: Starting Load Kernel Module 9pnet_virtio...467hub # [ 2.052219] systemd[1]: Starting Load Kernel Module configfs...468hub # [ 2.066633] systemd[1]: Starting Journal Service...469hub # [ 2.081970] systemd[1]: Starting Load Kernel Modules...470hub # [ 2.087013] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os471hub # [ 2.089496] netfs: FS-Cache loaded472hub # [ 2.097073] systemd[1]: Starting Coldplug All udev Devices...473hub # [ 2.109276] 9pnet: Installing 9P2000 support474hub # [ 2.120046] systemd[1]: Finished Create List of Static Device Nodes.475hub # [ 2.126487] systemd-journald[67]: Collecting audit messages is disabled.476hub # [ 2.133690] systemd[1]: modprobe@configfs.service: Deactivated successfully.477hub # [ 2.142438] systemd[1]: Finished Load Kernel Module configfs.478hub # [ 2.156069] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.479hub # [ 2.167491] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480hub # [ 2.169512] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev481hub # [ 2.176962] systemd[1]: Finished Load Kernel Module 9pnet_virtio.482hub # [ 2.186087] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config483hub # [ 2.200976] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...484hub # [ 2.216056] systemd[1]: Finished Load Kernel Modules.485hub # [ 2.226040] systemd[1]: Starting Apply Kernel Variables...486hub # [ 2.241975] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.487hub # [ 2.254124] systemd[1]: Starting Create Static Device Nodes in /dev...488hub # [ 2.268977] systemd[1]: Finished Apply Kernel Variables.489hub # [ 2.289053] systemd[1]: Started Journal Service.490hub # [ 2.083280] systemd-modules-load[68]: Inserted module 'dm_mod'491hub # [ 2.086437] systemd-modules-load[68]: Inserted module 'virtio_balloon'492hub # [ 2.088455] systemd-modules-load[68]: Inserted module 'virtio_gpu'493hub # [ 2.091441] systemd[1]: Finished Create Static Device Nodes in /dev.494hub # [ 2.101922] systemd[1]: Reached target Preparation for Local File Systems.495hub # [ 2.104107] systemd[1]: Reached target Local File Systems.496hub # [ 2.108081] systemd[1]: Starting Create System Files and Directories...497hub # [ 2.114205] systemd[1]: Starting Rule-based Manager for Device Events and Files...498hub # [ 2.139246] systemd[1]: Finished Create System Files and Directories.499hub # [ 2.149189] systemd[1]: Finished Coldplug All udev Devices.500hub # [ 2.157274] systemd-udevd[83]: Using default interface naming scheme 'v261'.501hub # [ 2.173528] systemd[1]: Started Rule-based Manager for Device Events and Files.502hub # [ 2.176635] systemd[1]: Reached target System Initialization.503hub # [ 2.177836] systemd[1]: Reached target Basic System.504hub # [ 2.623204] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12505hub # [ 2.626827] virtio_blk virtio5: 1/0/0 default/read/poll queues506hub # [ 2.654365] serio: i8042 KBD port at 0x60,0x64 irq 1507hub # [ 2.655348] serio: i8042 AUX port at 0x60,0x64 irq 12508hub # [ 2.660673] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)509hub # [ 2.683076] ehci-pci 0000:00:1d.7: EHCI Host Controller510hub # [ 2.684371] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1511hub # [ 2.688151] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000512hub # [ 2.695016] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00513hub # [ 2.697897] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18514hub # [ 2.701682] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1515hub # [ 2.705152] usb usb1: Product: EHCI Host Controller516hub # [ 2.708078] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd517hub # [ 2.709901] usb usb1: SerialNumber: 0000:00:1d.7518hub # [ 2.712385] hub 1-0:1.0: USB hub found519hub # [ 2.714785] hub 1-0:1.0: 6 ports detected520hub # [ 2.720962] uhci_hcd 0000:00:1d.0: UHCI Host Controller521hub # [ 2.721980] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2522hub # [ 2.736921] uhci_hcd 0000:00:1d.0: detected 2 ports523hub # [ 2.741709] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200524hub # [ 2.762705] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18525hub # [ 2.560715] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.526hub # [ 2.564040] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.527hub # [ 2.575052] systemd[1]: Starting Virtual Console Setup...528hub # [ 2.787820] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1529hub # [ 2.792355] SCSI subsystem initialized530hub # [ 2.590730] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.531hub # [ 2.812703] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0532hub # [ 2.614695] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.533hub # [ 2.619301] systemd[1]: Finished Virtual Console Setup.534hub # [ 2.830263] usb usb2: Product: UHCI Host Controller535hub # [ 2.839906] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd536hub # [ 2.847297] usb usb2: SerialNumber: 0000:00:1d.0537hub # [ 2.852049] hub 2-0:1.0: USB hub found538hub # [ 2.857914] hub 2-0:1.0: 2 ports detected539hub # [ 2.651337] systemd[1]: Found device /dev/disk/by-label/nixos.540hub # [ 2.654080] systemd[1]: Reached target Initrd Root Device.541hub # [ 2.658083] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...542hub # [ 2.871066] uhci_hcd 0000:00:1d.1: UHCI Host Controller543hub # [ 2.875910] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3544hub # [ 2.882944] uhci_hcd 0000:00:1d.1: detected 2 ports545hub # [ 2.889556] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220546hub # [ 2.893442] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18547hub # [ 2.897946] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1548hub # [ 2.900955] usb usb3: Product: UHCI Host Controller549hub # [ 2.903926] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd550hub # [ 2.701063] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks551hub # [ 2.917049] usb usb3: SerialNumber: 0000:00:1d.1552hub # [ 2.711291] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.553hub # [ 2.925321] hub 3-0:1.0: USB hub found554hub # [ 2.930121] hub 3-0:1.0: 2 ports detected555hub # [ 2.938617] uhci_hcd 0000:00:1d.2: UHCI Host Controller556hub # [ 2.963051] usb 1-1: new high-speed USB device number 2 using ehci-pci557hub # [ 2.969511] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode558hub # [ 2.971578] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4559hub # [ 2.974809] uhci_hcd 0000:00:1d.2: detected 2 ports560hub # [ 2.976604] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)561hub # [ 2.981435] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240562hub # [ 2.984060] ahci 0000:00:1f.2: flags: 64bit ncq only563hub # [ 2.986962] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18564hub # [ 2.989117] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1565hub # [ 2.998235] scsi host0: ahci566hub # [ 3.000235] usb usb4: Product: UHCI Host Controller567hub # [ 3.002757] scsi host1: ahci568hub # [ 3.006812] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd569hub # [ 3.009962] scsi host2: ahci570hub # [ 3.013038] scsi host3: ahci571hub # [ 3.014929] usb usb4: SerialNumber: 0000:00:1d.2572hub # [ 3.021498] scsi host4: ahci573hub # [ 3.023430] hub 4-0:1.0: USB hub found574hub # [ 3.026839] scsi host5: ahci575hub # [ 3.027755] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1576hub # [ 3.031795] hub 4-0:1.0: 2 ports detected577hub # [ 3.041745] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1578hub # [ 3.049913] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1579hub # [ 3.059718] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1580hub # [ 3.070216] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1581hub # [ 3.075523] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1582hub # [ 3.097377] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00583hub # [ 3.099249] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10584hub # [ 3.101477] usb 1-1: Product: QEMU USB Tablet585hub # [ 3.102749] usb 1-1: Manufacturer: QEMU586hub # [ 3.103891] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1587hub # [ 2.909388] systemd[1]: Mounting /sysroot...588hub # [ 3.125392] hid: raw HID events driver (C) Jiri Kosina589hub # [ 3.389269] ata4: SATA link down (SStatus 0 SControl 300)590hub # [ 3.390756] ata1: SATA link down (SStatus 0 SControl 300)591hub # [ 3.392196] ata5: SATA link down (SStatus 0 SControl 300)592hub # [ 3.393518] ata6: SATA link down (SStatus 0 SControl 300)593hub # [ 3.394824] ata2: SATA link down (SStatus 0 SControl 300)594hub # [ 3.396169] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)595hub # [ 3.397454] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100596hub # [ 3.399472] ata3.00: applying bridge limits597hub # [ 3.400627] ata3.00: configured for UDMA/100598hub # [ 3.402128] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5599hub # [ 3.461733] usbcore: registered new interface driver usbhid600hub # [ 3.468443] usbhid: USB HID core driver601hub # [ 3.497280] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2602hub # [ 3.502651] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0603hub # [ 3.508342] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray604hub # [ 3.517552] EXT4-fs (vda): mounted filesystem 6667df2e-e7b5-43b3-8d47-cd1d8d5ef898 r/w with ordered data mode. Quota mode: none.605hub # [ 3.524369] cdrom: Uniform CD-ROM driver Revision: 3.20606hub # [ 3.318328] systemd[1]: Mounted /sysroot.607hub # [ 3.319318] systemd[1]: Reached target Initrd Root File System.608hub # [ 3.323901] systemd[1]: Starting Mountpoints Configured in the Real Root...609hub # [ 3.343988] systemd-sysroot-fstab-check[145]: /sysroot should be mounted in the initrd, will request daemon-reload.610hub # [ 3.348636] systemd[1]: Reload requested from client PID 145 ('systemd-sysroot') (unit initrd-parse-etc.service)...611hub # [ 3.350881] systemd[1]: Reloading...612hub # [ 3.456211] systemd[1]: Reloading finished in 107 ms.613hub # [ 3.472750] systemd-sysroot-fstab-check[145]: Requesting initrd-fs.target/start/replace...614hub # [ 3.483355] systemd-sysroot-fstab-check[145]: Requesting swap.target/start/replace...615hub # [ 3.495815] systemd[1]: initrd-parse-etc.service: Deactivated successfully.616hub # [ 3.498676] systemd[1]: Finished Mountpoints Configured in the Real Root.617hub # [ 3.501666] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.618hub # [ 3.506411] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio619hub # [ 3.908129] systemd[1]: Mounting /sysroot/nix/.ro-store...620hub # [ 3.911940] systemd[1]: Mounting /sysroot/nix/.rw-store...621hub # [ 3.917239] systemd[1]: Mounting /sysroot/run...622hub # [ 3.924167] systemd[1]: Mounting /sysroot/tmp/shared...623hub # [ 3.927145] systemd[1]: Mounting /sysroot/tmp/xchg...624hub # [ 4.163320] 9p: Installing v9fs 9p2000 file system support625hub # [ 3.958089] systemd[1]: Mounted /sysroot/run.626hub # [ 3.959285] systemd[1]: Mounted /sysroot/nix/.rw-store.627hub # [ 3.968731] systemd[1]: Mounted /sysroot/nix/.ro-store.628hub # [ 3.971095] systemd[1]: Mounted /sysroot/tmp/shared.629hub # [ 3.972369] systemd[1]: Mounted /sysroot/tmp/xchg.630hub # [ 3.976165] systemd[1]: Starting rw-sysroot-nix-store.service...631hub # [ 3.986901] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.632hub # [ 3.989096] systemd[1]: Finished rw-sysroot-nix-store.service.633hub # [ 4.907697] systemd[1]: Mounting /sysroot/nix/store...634hub # [ 4.927184] systemd[1]: Mounted /sysroot/nix/store.635hub # [ 4.929104] systemd[1]: Reached target Initrd File Systems.636hub # [ 4.932106] systemd[1]: Starting Find NixOS closure...637hub # [ 4.936215] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...638hub # [ 4.956803] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.639hub # [ 4.961433] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.640hub # [ 4.969171] systemd[1]: Finished Find NixOS closure.641hub # [ 4.971518] systemd[1]: Reached target Initrd Default Target.642hub # [ 4.974094] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...643hub # [ 4.992321] systemd[1]: Stopped target Initrd Default Target.644hub # [ 4.993712] systemd[1]: Stopped target Basic System.645hub # [ 4.994998] systemd[1]: Stopped target Initrd Root Device.646hub # [ 4.998209] systemd[1]: Stopped target Path Units.647hub # [ 4.999421] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.648hub # [ 5.001171] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.649hub # [ 5.003089] systemd[1]: Stopped target Slice Units.650hub # [ 5.004420] systemd[1]: Stopped target Socket Units.651hub # [ 5.006531] systemd[1]: Stopped target System Initialization.652hub # [ 5.008279] systemd[1]: Stopped target Swaps.653hub # [ 5.009674] systemd[1]: Stopped target Timer Units.654hub # [ 5.011200] systemd[1]: dbus.socket: Deactivated successfully.655hub # [ 5.013204] systemd[1]: Closed D-Bus System Message Bus Socket.656hub # [ 5.014720] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.657hub # [ 5.016942] systemd[1]: Stopped Find NixOS closure.658hub # [ 5.018598] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio659hub # [ 5.022290] systemd[1]: Starting rw-sysroot-nix-store.service...660hub # [ 5.023699] systemd[1]: systemd-sysctl.service: Deactivated successfully.661hub # [ 5.025544] systemd[1]: Stopped Apply Kernel Variables.662hub # [ 5.027093] systemd[1]: systemd-modules-load.service: Deactivated successfully.663hub # [ 5.029089] systemd[1]: Stopped Load Kernel Modules.664hub # [ 5.031315] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.665hub # [ 5.033375] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.666hub # [ 5.035475] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.667hub # [ 5.038170] systemd[1]: Stopped Create System Files and Directories.668hub # [ 5.039740] systemd[1]: Stopped target Local File Systems.669hub # [ 5.041153] systemd[1]: Stopped target Preparation for Local File Systems.670hub # [ 5.043952] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.671hub # [ 5.045709] systemd[1]: Stopped Coldplug All udev Devices.672hub # [ 5.048809] systemd[1]: Stopping Rule-based Manager for Device Events and Files...673hub # [ 5.050639] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.674hub # [ 5.053205] systemd[1]: Stopped Virtual Console Setup.675hub # [ 5.063757] systemd[1]: initrd-cleanup.service: Deactivated successfully.676hub # [ 5.068154] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.677hub # [ 5.069651] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.678hub # [ 5.072101] systemd[1]: Finished rw-sysroot-nix-store.service.679hub # [ 5.074766] systemd[1]: systemd-udevd.service: Deactivated successfully.680hub # [ 5.076812] systemd[1]: Stopped Rule-based Manager for Device Events and Files.681hub # [ 5.082093] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.682hub # [ 5.083669] systemd[1]: Closed udev Control Socket.683hub # [ 5.086247] systemd[1]: Starting Cleanup udev Database...684hub # [ 5.088225] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.685hub # [ 5.089858] systemd[1]: Stopped Create Static Device Nodes in /dev.686hub # [ 5.091493] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.687hub # [ 5.094247] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.688hub # [ 5.095689] systemd[1]: kmod-static-nodes.service: Deactivated successfully.689hub # [ 5.097192] systemd[1]: Stopped Create List of Static Device Nodes.690hub # [ 5.110187] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.691hub # [ 5.112768] systemd[1]: Finished Cleanup udev Database.692hub # [ 5.114846] systemd[1]: Reached target Switch Root.693hub # [ 5.117087] systemd[1]: Starting NixOS Activation...694hub # [ 5.239588] initrd-nixos-activation-start[198]: booting system configuration /nix/store/za7cpnjid60r6wib33fzdwvm341yamj9-nixos-system-hub-test695hub # [ 5.294648] initrd-nixos-activation-start[198]: running activation script...696hub # [ 5.831946] initrd-nixos-activation-start[221]: setting up /etc...697hub # [ 6.086628] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.698hub # [ 6.090107] systemd[1]: Finished NixOS Activation.699hub # [ 6.092661] systemd[1]: Starting Switch Root...700hub # [ 6.107371] systemd[1]: Switching root.701hub # [ 6.442762] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).702hub # [ 6.580264] NET: Registered PF_VSOCK protocol family703hub # [ 6.972734] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)704hub # [ 6.979188] systemd[1]: Detected virtualization kvm.705hub # [ 6.980633] systemd[1]: Detected architecture x86-64.706hub # [ 6.981957] systemd[1]: Detected first boot.707hub # [ 6.986182] systemd[1]: Initializing machine ID from random generator.708hub # [ 7.123614] systemd[1]: bpf-restrict-fs: LSM BPF program attached709hub # [ 7.291711] systemd[1]: Applying preset policy.710hub # [ 7.868382] systemd[1]: Populated /etc with preset unit settings.711worker # Disk image does not exist, creating the virtualisation disk image...712worker # Formatting '/build/vm-state-worker/tmp.bi4E7sywE1', fmt=raw size=1073741824713worker # mke2fs 1.47.4 (6-Mar-2025)714worker # Discarding device blocks: 0/262144 done715worker # Creating filesystem with 262144 4k blocks and 65536 inodes716worker # Filesystem UUID: 62a6d2cc-f648-41e3-9fda-7669949658e8717worker # Superblock backups stored on blocks:718worker # 32768, 98304, 163840, 229376719worker # 720worker # Allocating group tables: 0/8 done721worker # Writing inode tables: 0/8 done722worker # Creating journal (8192 blocks): done723worker # Writing superblocks and filesystem accounting information: 0/8 done724worker # 725worker # Virtualisation disk image created.726worker # Creating Nix store image...727worker # Created Nix store image.728worker: QEMU running (pid 47)729(finished: start all VMs, in 9.18 seconds)730hub: waiting for unit headscale731hub: waiting for the VM to finish booting732worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)733worker # 734worker # 735worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC610+7EF2C610 CA00736worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)...737worker # 738worker # 739worker # 740worker # 741worker # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC610 7EF2C610 CB00742worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)...743worker # 744worker # 745worker # Booting from ROM...746hub # [ 8.700760] systemd[1]: initrd-switch-root.service: Deactivated successfully.747hub # [ 8.703395] systemd[1]: Stopped initrd-switch-root.service.748hub # [ 8.708518] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.749hub # [ 8.712705] systemd[1]: Created slice Slice /system/getty.750hub # [ 8.715325] systemd[1]: Created slice User and Session Slice.751hub # [ 8.717154] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.752hub # [ 8.719635] systemd[1]: Started Forward Password Requests to Wall Directory Watch.753hub # [ 8.721896] systemd[1]: Expecting device /dev/hvc0...754hub # [ 8.723375] systemd[1]: Expecting device /dev/ttyS0...755hub # [ 8.725011] systemd[1]: Reached target Local Encrypted Volumes.756hub # [ 8.726756] systemd[1]: Stopped target initrd-fs.target.757hub # [ 8.728218] systemd[1]: Stopped target initrd-root-fs.target.758hub # [ 8.729703] systemd[1]: Stopped target initrd-switch-root.target.759hub # [ 8.731360] systemd[1]: Reached target Virtual Machines and Containers.760hub # [ 8.733193] systemd[1]: Reached target Path Units.761hub # [ 8.734716] systemd[1]: Reached target Remote File Systems.762hub # [ 8.736389] systemd[1]: Reached target Slice Units.763hub # [ 8.737917] systemd[1]: Reached target Swaps.764hub # [ 8.744198] systemd[1]: Listening on Query the User Interactively for a Password.765hub # [ 8.752991] systemd[1]: Listening on Process Core Dump Socket.766hub # [ 8.767029] systemd[1]: Listening on Credential Encryption/Decryption.767hub # [ 8.777051] systemd[1]: Listening on Factory Reset Management.768hub # [ 8.779380] systemd[1]: Listening on Hostname Service Socket.769hub # [ 8.792289] systemd[1]: Starting Journal Log Access Socket...770hub # [ 8.794974] systemd[1]: Listening on Journal Audit Socket.771hub # [ 8.808191] systemd[1]: Listening on Console Output Muting Service Socket.772hub # [ 8.811262] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.773hub # [ 8.813773] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os774hub # [ 8.816375] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki775hub # [ 8.845905] systemd[1]: Listening on Disk Repartitioning Service Socket.776hub # [ 8.847800] systemd[1]: Listening on udev Control Socket.777hub # [ 8.851274] systemd[1]: Listening on udev Varlink Socket.778hub # [ 8.872475] systemd[1]: Mounting Huge Pages File System...779hub # [ 8.879360] systemd[1]: Mounting POSIX Message Queue File System...780hub # [ 8.883937] systemd[1]: Mounting Kernel Debug File System...781hub # [ 8.895899] systemd[1]: Mounting Kernel Trace File System...782hub # [ 8.919048] systemd[1]: Starting Create List of Static Device Nodes...783hub # [ 8.921673] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio784hub # [ 8.931702] systemd[1]: Starting Load Kernel Module configfs...785hub # [ 8.938651] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm786hub # [ 8.948050] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore787hub # [ 8.952562] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse788hub # [ 8.960410] systemd[1]: Mounting FUSE Control File System...789hub # [ 8.962439] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67790hub # [ 8.975993] systemd[1]: Starting Journal Service...791worker # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 2026792hub # [ 8.991275] systemd[1]: Starting Load Kernel Modules...793worker # [ 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/nsra6xj5gzd76180dzbn5iyski14kk1h-nixos-system-worker-test/init regInfo=/nix/store/0325rp6ipsv0bnxm27n9bi6rzk2cal3f-closure-info/registration console=ttyS0,115200n8 console=tty0794worker # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees.795worker # [ 0.000000] BIOS-provided physical RAM map:796worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable797worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved798worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved799worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd4fff] usable800worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd5000-0x000000007fffffff] reserved801worker # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved802hub # [ 9.012136] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...803worker # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved804worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved805worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved806worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved807worker # [ 0.000000] NX (Execute Disable) protection: active808worker # [ 0.000000] APIC: Static calls initialized809worker # [ 0.000000] SMBIOS 2.8 present.810worker # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014811worker # [ 0.000000] DMI: Memory slots populated: 1/1812worker # [ 0.000000] Hypervisor detected: KVM813worker # [ 0.000000] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000814worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00815worker # [ 0.000002] kvm-clock: using sched offset of 706820997 cycles816worker # [ 0.000004] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns817worker # [ 0.000008] tsc: Detected 3099.998 MHz processor818worker # [ 0.000901] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000819worker # [ 0.000942] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs820worker # [ 0.000946] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT821hub # [ 9.041017] systemd[1]: Starting Remount Root and Kernel File Systems...822worker # [ 0.003346] found SMP MP-table at [mem 0x000f5450-0x000f545f]823hub # [ 9.042705] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os824worker # [ 0.003369] Using GB pages for direct mapping825worker # [ 0.003502] RAMDISK: [mem 0x7e35d000-0x7ffcffff]826worker # [ 0.003516] ACPI: Early table checksum verification disabled827worker # [ 0.003520] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )828worker # [ 0.003525] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)829worker # [ 0.003530] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)830hub # [ 9.052391] systemd[1]: Starting Coldplug All udev Devices...831worker # [ 0.003538] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)832worker # [ 0.003540] ACPI: FACS 0x000000007FFE0000 000040833worker # [ 0.003542] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)834worker # [ 0.003545] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)835hub # [ 9.056073] systemd[1]: Listening on Journal Log Access Socket.836worker # [ 0.003547] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)837worker # [ 0.003549] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)838worker # [ 0.003551] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d]839worker # [ 0.003552] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219]840worker # [ 0.003552] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]841worker # [ 0.003553] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385]842worker # [ 0.003554] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd]843worker # [ 0.003554] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9]844worker # [ 0.003555] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421]845worker # [ 0.004025] No NUMA configuration found846worker # [ 0.004027] Faking a node at [mem 0x0000000000000000-0x000000007ffd4fff]847worker # [ 0.004030] NODE_DATA(0) allocated [mem 0x7e357a80-0x7e35cfff]848worker # [ 0.004140] Zone ranges:849worker # [ 0.004140] DMA [mem 0x0000000000001000-0x0000000000ffffff]850worker # [ 0.004142] DMA32 [mem 0x0000000001000000-0x000000007ffd4fff]851worker # [ 0.004143] Normal empty852worker # [ 0.004144] Device empty853worker # [ 0.004145] Movable zone start for each node854worker # [ 0.004145] Early memory node ranges855worker # [ 0.004146] node 0: [mem 0x0000000000001000-0x000000000009efff]856worker # [ 0.004147] node 0: [mem 0x0000000000100000-0x000000007ffd4fff]857worker # [ 0.004148] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd4fff]858worker # [ 0.004174] On node 0, zone DMA: 1 pages in unavailable ranges859worker # [ 0.004469] On node 0, zone DMA: 97 pages in unavailable ranges860worker # [ 0.052287] On node 0, zone DMA32: 43 pages in unavailable ranges861worker # [ 0.053356] ACPI: PM-Timer IO Port: 0x608862worker # [ 0.053375] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])863worker # [ 0.053401] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23864worker # [ 0.053404] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)865worker # [ 0.053406] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)866worker # [ 0.053408] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)867worker # [ 0.053409] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)868worker # [ 0.053410] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)869worker # [ 0.053413] ACPI: Using ACPI (MADT) for SMP configuration information870worker # [ 0.053414] ACPI: HPET id: 0x8086a201 base: 0xfed00000871worker # [ 0.053420] TSC deadline timer available872worker # [ 0.053425] CPU topo: Max. logical packages: 1873worker # [ 0.053426] CPU topo: Max. logical dies: 1874worker # [ 0.053426] CPU topo: Max. dies per package: 1875worker # [ 0.053430] CPU topo: Max. threads per core: 1876worker # [ 0.053431] CPU topo: Num. cores per package: 1877worker # [ 0.053432] CPU topo: Num. threads per package: 1878worker # [ 0.053432] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs879worker # [ 0.053455] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()880worker # [ 0.053495] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]881worker # [ 0.053497] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]882worker # [ 0.053498] [mem 0xc0000000-0xfed1bfff] available for PCI devices883worker # [ 0.053500] Booting paravirtualized kernel on KVM884worker # [ 0.053504] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns885worker # [ 0.059009] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1886worker # [ 0.062771] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152887worker # [ 0.062859] kvm-guest: PV spinlocks disabled, single CPU888worker # [ 0.062863] 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/nsra6xj5gzd76180dzbn5iyski14kk1h-nixos-system-worker-test/init regInfo=/nix/store/0325rp6ipsv0bnxm27n9bi6rzk2cal3f-closure-info/registration console=ttyS0,115200n8 console=tty0889worker # [ 0.063033] Unknown kernel command line parameters "regInfo=/nix/store/0325rp6ipsv0bnxm27n9bi6rzk2cal3f-closure-info/registration", will be passed to user space.890worker # [ 0.063057] random: crng init done891worker # [ 0.063059] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes892worker # [ 0.066250] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)893worker # [ 0.067752] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)894worker # [ 0.067808] Fallback order for Node 0: 0895worker # [ 0.067812] Built 1 zonelists, mobility grouping on. Total pages: 524147896worker # [ 0.067814] Policy zone: DMA32897worker # [ 0.072796] mem auto-init: stack:all(zero), heap alloc:on, heap free:off898worker # [ 0.082389] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1899worker # [ 0.091319] allocated 4194304 bytes of page_ext900worker # [ 0.104958] ftrace: allocating 48733 entries in 192 pages901worker # [ 0.104965] ftrace: allocated 192 pages with 2 groups902worker # [ 0.106245] Dynamic Preempt: lazy903worker # [ 0.106456] rcu: Preemptible hierarchical RCU implementation.904worker # [ 0.106458] rcu: RCU event tracing is enabled.905worker # [ 0.106458] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.906worker # [ 0.106461] Trampoline variant of Tasks RCU enabled.907worker # [ 0.106461] Rude variant of Tasks RCU enabled.908worker # [ 0.106462] Tracing variant of Tasks RCU enabled.909worker # [ 0.106463] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.910worker # [ 0.106464] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1911worker # [ 0.106496] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.912worker # [ 0.106498] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.913worker # [ 0.106500] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.914worker # [ 0.115027] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16915worker # [ 0.115504] rcu: srcu_init: Setting srcu_struct sizes based on contention.916worker # [ 0.115514] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns917worker # [ 0.115661] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)918worker # [ 0.124411] Console: colour VGA+ 80x25919worker # [ 0.124421] printk: legacy console [tty0] enabled920hub # [ 9.184300] systemd[1]: Finished Create List of Static Device Nodes.921worker # [ 0.180702] printk: legacy console [ttyS0] enabled922worker # [ 0.380883] ACPI: Core revision 20250807923worker # [ 0.382328] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns924worker # [ 0.384757] APIC: Switch to symmetric I/O mode setup925worker # [ 0.386411] x2apic enabled926worker # [ 0.387697] APIC: Switched APIC routing to: physical x2apic927worker # [ 0.390737] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1928worker # [ 0.394139] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns929hub # [ 9.203711] systemd[1]: modprobe@configfs.service: Deactivated successfully.930worker # [ 0.397259] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998)931worker # [ 0.398368] x86/cpu: User Mode Instruction Prevention (UMIP) activated932worker # [ 0.401331] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127933worker # [ 0.402258] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0934worker # [ 0.404271] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto935worker # [ 0.406261] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl936worker # [ 0.408257] Spectre V2 : Mitigation: Retpolines937worker # [ 0.409256] RETBleed: Mitigation: untrained return thunk938hub # [ 9.219670] systemd-journald[291]: Collecting audit messages is enabled.939hub # [ 9.222632] systemd[1]: Finished Load Kernel Module configfs.940worker # [ 0.410259] Speculative Return Stack Overflow: Mitigation: SMT disabled941hub # [ 9.228865] EXT4-fs (vda): re-mounted 6667df2e-e7b5-43b3-8d47-cd1d8d5ef898.942worker # [ 0.413259] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization943worker # [ 0.414264] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT944worker # [ 0.416259] Spectre V2 : Enabling Speculation Barrier for firmware calls945worker # [ 0.417265] active return thunk: retbleed_return_thunk946worker # [ 0.418264] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier947worker # [ 0.420275] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'948worker # [ 0.421257] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'949worker # [ 0.422257] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'950worker # [ 0.423258] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256951worker # [ 0.425262] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.952hub # [ 9.254012] loop: module loaded953hub # [ 9.271624] systemd[1]: Finished Remount Root and Kernel File Systems.954worker # [ 0.456789] Freeing SMP alternatives memory: 44K955worker # [ 0.458268] pid_max: default: 32768 minimum: 301956worker # [ 0.459375] LSM: initializing lsm=capability,landlock,yama,bpf,ima957worker # [ 0.461267] landlock: Up and running.958hub # [ 9.287798] systemd[1]: Mounted Huge Pages File System.959worker # [ 0.462256] Yama: becoming mindful.960worker # [ 0.463503] LSM support for eBPF active961worker # [ 0.465308] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)962worker # [ 0.466337] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)963hub # [ 9.296309] systemd[1]: Started Journal Service.964worker # [ 0.469630] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0)965hub # [ 9.089064] systemd[1]: Queued start job for default target Multi-User System.966worker # [ 0.470944] Performance Events: Fam17h+ core perfctr, AMD PMU driver.967worker # [ 0.472262] ... version: 0968hub # [ 9.091597] systemd[1]: systemd-journald.service: Deactivated successfully.969worker # [ 0.473414] ... bit width: 48970worker # [ 0.474267] ... generic counters: 6971worker # [ 0.475260] ... generic bitmap: 000000000000003f972worker # [ 0.476260] ... fixed-purpose counters: 0973hub # [ 9.098666] systemd-modules-load[292]: Inserted module 'loop'974worker # [ 0.477261] ... fixed-purpose bitmap: 0000000000000000975worker # [ 0.478259] ... value mask: 0000ffffffffffff976worker # [ 0.479262] ... max period: 00007fffffffffff977worker # [ 0.480260] ... global_ctrl mask: 000000000000003f978hub # [ 9.103260] systemd-modules-load[292]: Inserted module 'tls'979worker # [ 0.481444] signal: max sigframe size: 1776980worker # [ 0.482457] rcu: Hierarchical SRCU implementation.981hub # [ 9.106674] systemd[1]: Mounted POSIX Message Queue File System.982worker # [ 0.483269] rcu: Max phase no-delay instances is 400.983hub # [ 9.111363] systemd[1]: Mounted Kernel Debug File System.984worker # [ 0.489233] smp: Bringing up secondary CPUs ...985hub # [ 9.115723] systemd[1]: Mounted Kernel Trace File System.986worker # [ 0.490297] smp: Brought up 1 node, 1 CPU987worker # [ 0.491277] smpboot: Total of 1 processors activated (6199.99 BogoMIPS)988hub # [ 9.120640] systemd[1]: Mounted FUSE Control File System.989worker # [ 0.492664] Memory: 1971544K/2096588K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115560K reserved, 0K cma-reserved)990worker # [ 0.494749] devtmpfs: initialized991hub # [ 9.124728] systemd[1]: Finished Load Kernel Modules.992worker # [ 0.495502] x86/mm: Memory block size: 128MB993worker # [ 0.497473] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)994worker # [ 0.498312] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).995hub # [ 9.130388] systemd-oomd[293]: No swap; memory pressure usage will be degraded996worker # [ 0.499498] pinctrl core: initialized pinctrl subsystem997worker # [ 0.500622] PM: RTC time: 15:05:37, date: 2026-10-06998worker # [ 0.504745] NET: Registered PF_NETLINK/PF_ROUTE protocol family999worker # [ 0.505892] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations1000worker # [ 0.507311] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1001hub # [ 9.146585] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1002worker # [ 0.508629] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1003worker # [ 0.509301] audit: initializing netlink subsys (disabled)1004worker # [ 0.510644] thermal_sys: Registered thermal governor 'fair_share'1005hub # [ 9.152182] systemd[1]: Listening on Disk Image Download Service Socket.1006worker # [ 0.510646] thermal_sys: Registered thermal governor 'bang_bang'1007worker # [ 0.511266] audit: type=2000 audit(1791299137.798:1): state=initialized audit_enabled=0 res=11008worker # [ 0.513269] thermal_sys: Registered thermal governor 'step_wise'1009hub # [ 9.157619] systemd[1]: Mounting Kernel Configuration File System...1010worker # [ 0.513272] thermal_sys: Registered thermal governor 'user_space'1011worker # [ 0.514260] thermal_sys: Registered thermal governor 'power_allocator'1012worker # [ 0.515306] cpuidle: using governor menu1013worker # [ 0.518390] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51014hub # [ 9.166139] systemd[1]: Starting Firewall...1015worker # [ 0.519606] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]1016worker # [ 0.520269] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry1017worker # [ 0.521288] PCI: Using configuration type 1 for base access1018worker # [ 0.522615] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.1019hub # [ 9.176149] systemd[1]: Starting Flush Journal to Persistent Storage...1020hub # [ 9.178128] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1021worker # [ 0.529395] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1022worker # [ 0.530260] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page1023worker # [ 0.535266] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1024worker # [ 0.536260] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page1025hub # [ 9.195971] systemd[1]: Starting Load/Save OS Random Seed...1026worker # [ 0.547936] ACPI: Added _OSI(Module Device)1027worker # [ 0.549182] ACPI: Added _OSI(Processor Device)1028worker # [ 0.554262] ACPI: Added _OSI(Processor Aggregator Device)1029hub # [ 9.212777] systemd[1]: Starting Apply Kernel Variables...1030worker # [ 0.561090] ACPI: 1 ACPI AML tables successfully acquired and loaded1031worker # [ 0.567382] ACPI: Interpreter enabled1032worker # [ 0.568281] ACPI: PM: (supports S0 S3 S4 S5)1033worker # [ 0.571268] ACPI: Using IOAPIC for interrupt routing1034worker # [ 0.572496] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug1035hub # [ 9.231661] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1036worker # [ 0.575262] PCI: Using E820 reservations for host bridge windows1037hub # [ 9.235600] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1038worker # [ 0.576460] ACPI: Enabled 2 GPEs in block 00 to 3F1039worker # [ 0.583846] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1040worker # [ 0.584277] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1041worker # [ 0.585379] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]1042worker # [ 0.586373] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]1043worker # [ 0.587874] PCI host bridge to bus 0000:001044worker # [ 0.588273] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]1045worker # [ 0.589266] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]1046worker # [ 0.590264] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]1047worker # [ 0.591261] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]1048worker # [ 0.592258] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]1049worker # [ 0.593263] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]1050worker # [ 0.594273] pci_bus 0000:00: root bus resource [bus 00-ff]1051worker # [ 0.595433] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint1052worker # [ 0.597380] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint1053hub # [ 9.485600] systemd-journald[291]: Received client request to flush runtime journal.1054worker # [ 0.600362] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]1055worker # [ 0.601295] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]1056worker # [ 0.602319] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]1057worker # [ 0.603552] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]1058worker # [ 0.606981] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1059worker # [ 0.610284] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f]1060worker # [ 0.611281] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]1061worker # [ 0.612318] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]1062worker # [ 0.613276] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]1063worker # [ 0.615507] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1064worker # [ 0.618283] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf]1065worker # [ 0.619277] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]1066worker # [ 0.620334] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]1067worker # [ 0.622875] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1068worker # [ 0.626446] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df]1069worker # [ 0.627284] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]1070worker # [ 0.628323] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]1071worker # [ 0.630683] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1072worker # [ 0.633281] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff]1073worker # [ 0.634292] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]1074worker # [ 0.635317] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]1075worker # [ 0.637694] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1076worker # [ 0.640282] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f]1077worker # [ 0.641280] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]1078worker # [ 0.642338] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]1079worker # [ 0.644494] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1080worker # [ 0.648279] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff]1081worker # [ 0.649281] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]1082worker # [ 0.650319] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]1083worker # [ 0.652591] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1084worker # [ 0.655277] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f]1085worker # [ 0.656276] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]1086worker # [ 0.657315] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]1087worker # [ 0.658282] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]1088worker # [ 0.660704] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1089worker # [ 0.662950] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]1090worker # [ 0.664333] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]1091worker # [ 0.666753] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1092worker # [ 0.670287] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f]1093worker # [ 0.671281] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]1094worker # [ 0.672330] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]1095worker # [ 0.674577] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1096worker # [ 0.677279] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f]1097worker # [ 0.678276] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]1098worker # [ 0.679333] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]1099worker # [ 0.682105] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint1100worker # [ 0.684333] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f]1101worker # [ 0.685748] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint1102worker # [ 0.688061] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f]1103worker # [ 0.689723] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint1104worker # [ 0.691336] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f]1105worker # [ 0.692909] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint1106worker # [ 0.695281] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]1107worker # [ 0.698011] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint1108worker # [ 0.700076] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO1109worker # [ 0.701867] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint1110worker # [ 0.705330] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf]1111worker # [ 0.706284] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]1112worker # [ 0.708185] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint1113worker # [ 0.710656] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]1114worker # [ 0.718210] ACPI: PCI: Interrupt link LNKA configured for IRQ 101115worker # [ 0.719432] ACPI: PCI: Interrupt link LNKB configured for IRQ 101116worker # [ 0.720463] ACPI: PCI: Interrupt link LNKC configured for IRQ 111117worker # [ 0.721423] ACPI: PCI: Interrupt link LNKD configured for IRQ 111118worker # [ 0.722414] ACPI: PCI: Interrupt link LNKE configured for IRQ 101119worker # [ 0.723408] ACPI: PCI: Interrupt link LNKF configured for IRQ 101120worker # [ 0.724412] ACPI: PCI: Interrupt link LNKG configured for IRQ 111121worker # [ 0.725414] ACPI: PCI: Interrupt link LNKH configured for IRQ 111122worker # [ 0.726331] ACPI: PCI: Interrupt link GSIA configured for IRQ 161123worker # [ 0.727280] ACPI: PCI: Interrupt link GSIB configured for IRQ 171124worker # [ 0.728283] ACPI: PCI: Interrupt link GSIC configured for IRQ 181125worker # [ 0.729299] ACPI: PCI: Interrupt link GSID configured for IRQ 191126worker # [ 0.730288] ACPI: PCI: Interrupt link GSIE configured for IRQ 201127worker # [ 0.731287] ACPI: PCI: Interrupt link GSIF configured for IRQ 211128worker # [ 0.732283] ACPI: PCI: Interrupt link GSIG configured for IRQ 221129worker # [ 0.733297] ACPI: PCI: Interrupt link GSIH configured for IRQ 231130worker # [ 0.735871] iommu: Default domain type: Translated1131worker # [ 0.736269] iommu: DMA domain TLB invalidation policy: lazy mode1132worker # [ 0.737576] ACPI: bus type USB registered1133worker # [ 0.738352] usbcore: registered new interface driver usbfs1134worker # [ 0.739285] usbcore: registered new interface driver hub1135worker # [ 0.740291] usbcore: registered new device driver usb1136worker # [ 0.742273] NetLabel: Initializing1137worker # [ 0.743258] NetLabel: domain hash size = 1281138hub # [ 9.532311] systemd[1]: Mounted Kernel Configuration File System.1139worker # [ 0.744259] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO1140worker # [ 0.745327] NetLabel: unlabeled traffic allowed by default1141worker # [ 0.746280] PCI: Using ACPI for IRQ routing1142hub # [ 9.539135] systemd[1]: Finished Load/Save OS Random Seed.1143hub # [ 9.542530] systemd[1]: Reached target First Boot Complete.1144hub # [ 9.544641] systemd[1]: Finished Apply Kernel Variables.1145hub # [ 9.546527] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1146hub # [ 9.549321] systemd[1]: Starting Create Static Device Nodes in /dev...1147hub # [ 9.551529] systemd[1]: Finished Coldplug All udev Devices.1148hub # [ 9.553211] systemd[1]: Finished Flush Journal to Persistent Storage.1149hub # [ 9.581767] systemd[1]: Finished Create Static Device Nodes in /dev.1150hub # [ 9.586158] systemd[1]: Reached target Preparation for Local File Systems.1151hub # [ 9.593180] systemd[1]: Mounting /run/wrappers...1152hub # [ 9.599386] systemd[1]: Starting Rule-based Manager for Device Events and Files...1153hub # [ 9.645193] systemd[1]: Mounted /run/wrappers.1154hub # [ 9.646913] systemd[1]: Reached target Local File Systems.1155worker # [ 0.858738] pci 0000:00:01.0: vgaarb: setting as boot VGA device1156worker # [ 0.859252] pci 0000:00:01.0: vgaarb: bridge control possible1157hub # [ 9.654776] systemd[1]: Listening on Boot Loader Control Service Socket.1158worker # [ 0.859252] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none1159worker # [ 0.859274] vgaarb: loaded1160worker # [ 0.860350] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 01161worker # [ 0.861258] hpet0: 3 comparators, 64-bit 100.000000 MHz counter1162hub # [ 9.661255] systemd[1]: Starting register-nix-paths.service...1163worker # [ 0.865422] clocksource: Switched to clocksource kvm-clock1164hub # [ 9.669259] systemd[1]: Starting Create SUID/SGID Wrappers...1165worker # [ 0.870385] VFS: Disk quotas dquot_6.6.01166hub # [ 9.671333] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1167worker # [ 0.871603] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1168worker # [ 0.873701] pnp: PnP ACPI init1169worker # [ 0.874921] ACPI: IRQ 4 override to edge(!), high(!)1170worker # [ 0.876567] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved1171worker # [ 0.878823] pnp: PnP ACPI: found 6 devices1172worker # [ 0.886563] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns1173worker # [ 0.889173] clocksource: Switched to clocksource acpi_pm1174hub # [ 9.689700] systemd[1]: Starting Save Transient machine-id to Disk...1175worker # [ 0.890878] NET: Registered PF_INET protocol family1176worker # [ 0.892998] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)1177hub # [ 9.709290] systemd[1]: Starting Create System Files and Directories...1178worker # [ 0.914013] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)1179worker # [ 0.916323] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1180worker # [ 0.918333] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)1181worker # [ 0.920876] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)1182worker # [ 0.923235] TCP: Hash tables configured (established 16384 bind 16384)1183worker # [ 0.925482] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)1184worker # [ 0.927959] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)1185worker # [ 0.929725] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)1186hub # [ 9.730601] systemd-udevd[335]: Using default interface naming scheme 'v261'.1187worker # [ 0.931950] NET: Registered PF_UNIX/PF_LOCAL protocol family1188worker # [ 0.933501] NET: Registered PF_XDP protocol family1189worker # [ 0.935176] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]1190worker # [ 0.936888] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]1191worker # [ 0.938594] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]1192worker # [ 0.940600] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]1193worker # [ 0.942863] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]1194worker # [ 0.944944] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]1195worker # [ 0.947982] ACPI: \_SB_.GSIA: Enabled at IRQ 161196worker # [ 0.951157] ACPI: \_SB_.GSIB: Enabled at IRQ 171197worker # [ 0.954717] ACPI: \_SB_.GSIC: Enabled at IRQ 181198worker # [ 0.957871] ACPI: \_SB_.GSID: Enabled at IRQ 191199worker # [ 0.960923] PCI: CLS 0 bytes, default 641200worker # [ 0.962948] Trying to unpack rootfs image as initramfs...1201worker # [ 0.965026] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns1202hub # [ 9.813445] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1203worker # [ 1.014636] Initialise system trusted keyrings1204worker # [ 1.019040] workingset: timestamp_bits=40 max_order=19 bucket_order=01205hub # [ 9.823685] systemd[1]: Finished Save Transient machine-id to Disk.1206worker # [ 1.048161] Key type asymmetric registered1207worker # [ 1.049450] Asymmetric key parser 'x509' registered1208worker # [ 1.054855] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)1209worker # [ 1.059857] io scheduler mq-deadline registered1210worker # [ 1.061208] io scheduler kyber registered1211worker # [ 1.067008] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1212worker # [ 1.069158] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1213worker # [ 1.078199] Linux agpgart interface v0.1031214worker # [ 1.079641] ACPI: bus type drm_connector registered1215worker # [ 1.085049] usbcore: registered new interface driver usbserial_generic1216worker # [ 1.087099] usbserial: USB Serial support registered for generic1217hub # [ 9.893877] systemd[1]: Finished Create System Files and Directories.1218worker # [ 1.092827] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1219worker # [ 1.095478] drop_monitor: Initializing network drop monitor service1220worker # [ 1.101992] NET: Registered PF_INET6 protocol family1221hub # [ 9.906465] systemd[1]: Starting Rebuild Journal Catalog...1222worker # [ 1.107501] Segment Routing with IPv61223worker # [ 1.111147] In-situ OAM (IOAM) with IPv61224worker # [ 1.112996] IPI shorthand broadcast: enabled1225hub # [ 9.916824] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1226worker # [ 1.121536] sched_clock: Marking stable (844034301, 276739501)->(1322336166, -201562364)1227worker # [ 1.130173] registered taskstats version 11228worker # [ 1.134143] Loading compiled-in X.509 certificates1229worker # [ 1.155817] Demotion targets for Node 0: null1230worker # [ 1.159860] Key type .fscrypt registered1231worker # [ 1.161381] Key type fscrypt-provisioning registered1232worker # [ 1.166004] ima: No TPM chip found, activating TPM-bypass!1233worker # [ 1.169820] ima: Allocated hash algorithm: sha11234worker # [ 1.171291] ima: No architecture policies found1235worker # [ 1.174994] PM: Magic number: 14:578:821236worker # [ 1.179390] RAS: Correctable Errors collector initialized.1237worker # [ 1.194130] clk: Disabling unused clocks1238worker # [ 1.195329] PM: genpd: Disabling unused power domains1239hub # [ 10.033326] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1240hub # [ 10.037934] systemd[1]: Started Rule-based Manager for Device Events and Files.1241hub # [ 10.084592] systemd[1]: Finished Rebuild Journal Catalog.1242hub # [ 10.098135] systemd[1]: Starting Update is Completed...1243hub # [ 10.165801] systemd[1]: Finished Update is Completed.1244worker # [ 1.492031] Freeing initrd memory: 29132K1245worker # [ 1.496416] Freeing unused decrypted memory: 2028K1246worker # [ 1.499932] Freeing unused kernel image (initmem) memory: 3644K1247worker # [ 1.501888] Write protecting the kernel read-only data: 32768k1248worker # [ 1.504426] Freeing unused kernel image (text/rodata gap) memory: 1216K1249worker # [ 1.506673] Freeing unused kernel image (rodata/data gap) memory: 756K1250worker # [ 1.548211] x86/mm: Checked W+X mappings: passed, no W+X pages found.1251worker # [ 1.550091] Run /init as init process1252worker # [ 1.561524] systemd[1]: Inserted module 'autofs4'1253worker # [ 1.581988] fuse: init (API version 7.45)1254worker # [ 1.590086] ACPI: \_SB_.GSIG: Enabled at IRQ 221255worker # [ 1.594206] ACPI: \_SB_.GSIH: Enabled at IRQ 231256worker # [ 1.599347] ACPI: \_SB_.GSIE: Enabled at IRQ 201257worker # [ 1.603416] ACPI: \_SB_.GSIF: Enabled at IRQ 211258worker # [ 1.641884] systemd[1]: Successfully made /usr/ read-only.1259hub # [ 10.450368] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1260hub # [ 10.539929] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1261hub # [ 10.544237] systemd[1]: Finished Create SUID/SGID Wrappers.1262hub # [ 10.647646] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1263hub # [ 10.764982] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1264hub # [ 10.778751] (udev-worker)[424]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1265hub # [ 10.784439] (udev-worker)[421]: Network interface NamePolicy= disabled on kernel command line.1266worker # [ 1.980231] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1267worker # [ 1.988289] systemd[1]: Detected virtualization kvm.1268hub # [ 10.788393] (udev-worker)[424]: Network interface NamePolicy= disabled on kernel command line.1269worker # [ 1.989816] systemd[1]: Detected architecture x86-64.1270worker # [ 1.991374] systemd[1]: Running in initrd.1271worker # [ 1.993214] systemd[1]: Initializing machine ID from random generator.1272worker # [ 1.996031] systemd[1]: Hostname set to <worker>.1273worker # [ 2.204684] systemd[1]: bpf-restrict-fs: LSM BPF program attached1274worker # [ 2.316801] systemd[1]: Queued start job for default target Initrd Default Target.1275worker # [ 2.324863] systemd[1]: Created slice Slice /system/modprobe.1276worker # [ 2.326853] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1277hub # [ 11.130224] systemd[1]: Condition check resulted in Virtio network device being skipped.1278worker # [ 2.329391] systemd[1]: Expecting device /dev/disk/by-label/nix-store...1279worker # [ 2.331087] systemd[1]: Expecting device /dev/disk/by-label/nixos...1280worker # [ 2.332907] systemd[1]: Reached target Path Units.1281hub # [ 11.133098] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1282worker # [ 2.334582] systemd[1]: Reached target Slice Units.1283worker # [ 2.336324] systemd[1]: Reached target Swaps.1284worker # [ 2.337828] systemd[1]: Reached target Timer Units.1285worker # [ 2.339637] systemd[1]: Listening on D-Bus System Message Bus Socket.1286worker # [ 2.342723] systemd[1]: Listening on Journal Socket (/dev/log).1287hub # [ 11.144113] systemd[1]: Starting Create SUID/SGID Wrappers...1288worker # [ 2.345315] systemd[1]: Listening on Journal Sockets.1289hub # [ 11.146792] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1290worker # [ 2.346937] systemd[1]: Listening on udev Control Socket.1291worker # [ 2.348915] systemd[1]: Listening on udev Kernel Socket.1292worker # [ 2.350923] systemd[1]: Reached target Socket Units.1293hub # [ 11.150098] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671294hub # [ 11.154833] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1295worker # [ 2.354110] systemd[1]: Starting Create List of Static Device Nodes...1296hub # [ 11.158338] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1297hub # [ 11.161385] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1298worker # [ 2.364299] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1299worker # [ 2.375890] systemd[1]: Starting Load Kernel Module configfs...1300hub # [ 11.176360] systemd[1]: Finished register-nix-paths.service.1301hub # [ 11.395779] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1302worker # [ 2.395978] systemd[1]: Starting Journal Service...1303worker # [ 2.414550] systemd[1]: Starting Load Kernel Modules...1304worker # [ 2.424609] netfs: FS-Cache loaded1305worker # [ 2.426961] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1306worker # [ 2.444914] 9pnet: Installing 9P2000 support1307worker # [ 2.448032] systemd[1]: Starting Coldplug All udev Devices...1308worker # [ 2.481024] systemd[1]: Finished Create List of Static Device Nodes.1309worker # [ 2.496007] systemd-journald[67]: Collecting audit messages is disabled.1310worker # [ 2.498435] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1311hub # [ 11.448333] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31312worker # [ 2.522805] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1313worker # [ 2.528488] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1314hub # [ 11.456065] ACPI: button: Power Button [PWRF]1315worker # [ 2.534801] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1316worker # [ 2.541516] systemd[1]: modprobe@configfs.service: Deactivated successfully.1317hub # [ 11.523484] Console: switching to colour dummy device 80x251318hub # [ 11.563598] [drm] Found bochs VGA, ID 0xb0c5.1319hub # [ 11.563601] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1320worker # [ 2.555858] systemd[1]: Finished Load Kernel Module configfs.1321worker # [ 2.565686] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1322hub # [ 11.579321] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1323hub # [ 11.580316] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01324worker # [ 2.586927] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1325hub # [ 11.601980] mousedev: PS/2 mouse device common for all mice1326hub # [ 11.614559] rtc_cmos 00:04: RTC can wake from S41327worker # [ 2.610902] systemd[1]: Finished Load Kernel Modules.1328worker # [ 2.620859] systemd[1]: Starting Apply Kernel Variables...1329worker # [ 2.639881] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1330hub # [ 11.657531] parport_pc 00:02: reported by Plug and Play ACPI1331hub # [ 11.659331] rtc_cmos 00:04: registered as rtc01332worker # [ 2.656947] systemd[1]: Starting Create Static Device Nodes in /dev...1333hub # [ 11.678704] rtc_cmos 00:04: setting system clock to 2026-10-06T15:05:39 UTC (1791299139)1334hub # [ 11.681311] systemd-journald[291]: Time jumped backwards, rotating.1335worker # [ 2.680905] systemd[1]: Finished Apply Kernel Variables.1336hub # [ 11.690338] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41337worker # [ 2.426386] systemd-modules-load[68]: Inserted module 'dm_mod'[ 2.704999] systemd[1]: Finished Create Static Device Nodes in /dev.1338worker # 1339worker # [ 2.431837] systemd-modules-load[68]: Inserted module 'virtio_balloon'1340worker # [ 2.710270] systemd[1]: Started Journal Service.1341worker # [ 2.435050] systemd-modules-load[68]: Inserted module 'virtio_gpu'1342worker # [ 2.449175] systemd[1]: Reached target Preparation for Local File Systems.1343worker # [ 2.451138] systemd[1]: Reached target Local File Systems.1344worker # [ 2.456175] systemd[1]: Starting Create System Files and Directories...1345hub # [ 11.543244] systemd[1]: Finished Firewall.1346worker # [ 2.466123] systemd[1]: Starting Rule-based Manager for Device Events and Files...1347worker # [ 2.498693] systemd[1]: Finished Create System Files and Directories.1348worker # [ 2.517697] systemd[1]: Finished Coldplug All udev Devices.1349worker # [ 2.522571] systemd-udevd[82]: Using default interface naming scheme 'v261'.1350worker # [ 2.541503] systemd[1]: Started Rule-based Manager for Device Events and Files.1351worker # [ 2.544900] systemd[1]: Reached target System Initialization.1352worker # [ 2.547457] systemd[1]: Reached target Basic System.1353hub # [ 11.786312] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1354hub # [ 11.790146] systemd[1]: Finished Create SUID/SGID Wrappers.1355hub # [ 11.794116] systemd[1]: Reached target System Initialization.1356hub # [ 11.797412] systemd[1]: Started Discard unused filesystem blocks once a week.1357hub # [ 11.799916] systemd[1]: Started Daily Cleanup of Temporary Directories.1358hub # [ 11.801435] systemd[1]: Reached target Timer Units.1359hub # [ 11.807590] systemd[1]: Listening on D-Bus System Message Bus Socket.1360hub # [ 11.810461] systemd[1]: Listening on Nix Daemon Socket.1361hub # [ 11.812446] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1362hub # [ 11.816293] systemd[1]: Reached target Socket Units.1363hub # [ 11.820249] systemd[1]: Reached target Basic System.1364hub # [ 11.823065] systemd[1]: Started backdoor.service.1365hub # [ 11.834117] systemd[1]: Starting Import lastlog data into lastlog2 database...1366hub # [ 11.847361] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1367worker # [ 3.055297] virtio_blk virtio4: 1/0/0 default/read/poll queues1368hub # [ 11.866772] systemd[1]: Starting Post-Boot Actions...1369hub # [ 11.887830] systemd[1]: Started Reset console on configuration changes.1370worker # [ 3.097624] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1371hub # [ 11.716291] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1372hub # [ 11.911474] systemd[1]: Starting resolvconf update...1373worker # [ 3.125820] ehci-pci 0000:00:1d.7: EHCI Host Controller1374worker # [ 3.126903] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11375worker # [ 3.132113] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001376hub # connecting to host...1377worker # [ 3.139815] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001378worker # [ 3.142902] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181379worker # [ 3.144589] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11380worker # [ 3.151767] usb usb1: Product: EHCI Host Controller1381worker # [ 3.153438] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd1382worker # [ 3.155479] usb usb1: SerialNumber: 0000:00:1d.71383worker # [ 3.157294] hub 1-0:1.0: USB hub found1384worker # [ 3.159430] hub 1-0:1.0: 6 ports detected1385worker # [ 3.162594] virtio_blk virtio5: 1/0/0 default/read/poll queues1386hub: Guest shell says: b'Spawning backdoor root shell...\n'1387worker # [ 3.168836] uhci_hcd 0000:00:1d.0: UHCI Host Controller1388worker # [ 3.169981] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21389hub: connected to guest root shell1390worker # [ 3.174894] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121391hub: (connecting took 4.06 seconds)1392worker # [ 3.178505] virtio_blk virtio5: [vdb] 2102704 512-byte logical blocks (1.08 GB/1.00 GiB)1393hub # [ 11.975783] nsncd[592]: Oct 06 15:05:40.004 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1394hub: (finished: waiting for the VM to finish booting, in 4.06 seconds)1395hub # [ 11.979641] systemd[1]: Started Name Service Cache Daemon (nsncd).1396worker # [ 3.186034] serio: i8042 KBD port at 0x60,0x64 irq 11397worker # [ 3.191831] uhci_hcd 0000:00:1d.0: detected 2 ports1398hub # [ 11.721119] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1399hub # [ 11.999161] systemd[1]: Finished Post-Boot Actions.1400worker # [ 3.201357] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2401401worker # [ 3.206225] serio: i8042 AUX port at 0x60,0x64 irq 121402worker # [ 3.211298] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181403worker # [ 3.220944] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11404worker # [ 3.236165] usb usb2: Product: UHCI Host Controller1405hub # [ 12.043122] systemd[1]: Reached target Host and Network Name Lookups.1406hub # [ 12.046706] systemd[1]: Reached target User and Group Name Lookups.1407worker # [ 3.248156] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd1408worker # [ 3.255311] SCSI subsystem initialized1409hub # [ 12.059645] systemd[1]: Starting D-Bus System Message Bus...1410worker # [ 3.263771] usb usb2: SerialNumber: 0000:00:1d.01411hub # [ 11.726226] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1412worker # [ 2.999471] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1413hub # [ 12.080944] systemd[1]: Starting User Login Management...1414worker # [ 3.282367] hub 2-0:1.0: USB hub found1415worker # [ 3.010327] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1416worker # [ 3.014532] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.1417hub # [ 12.093157] systemd[1]: Starting Virtual Console Setup...1418worker # [ 3.019946] systemd[1]: Starting Virtual Console Setup...1419hub # [ 11.889994] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1420hub # [ 11.890117] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1421worker # [ 3.313422] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01422worker # [ 3.316991] hub 2-0:1.0: 2 ports detected1423hub # [ 12.117155] systemd[1]: Finished Import lastlog data into lastlog2 database.1424worker # [ 3.056474] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1425worker # [ 3.060981] systemd[1]: Finished Virtual Console Setup.1426worker # [ 3.352488] uhci_hcd 0000:00:1d.1: UHCI Host Controller1427worker # [ 3.364123] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31428worker # [ 3.365861] uhci_hcd 0000:00:1d.1: detected 2 ports1429worker # [ 3.102549] systemd[1]: Found device /dev/disk/by-label/nix-store.1430worker # [ 3.380915] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2601431worker # [ 3.113234] systemd[1]: Found device /dev/disk/by-label/nixos.1432worker # [ 3.114824] systemd[1]: Reached target Initrd Root Device.1433worker # [ 3.393596] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181434worker # [ 3.120102] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1435worker # [ 3.401772] usb 1-1: new high-speed USB device number 2 using ehci-pci1436worker # [ 3.404859] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11437worker # [ 3.406532] usb usb3: Product: UHCI Host Controller1438worker # [ 3.413472] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1439worker # [ 3.415760] usb usb3: SerialNumber: 0000:00:1d.11440worker # [ 3.420843] hub 3-0:1.0: USB hub found1441hub # [ 11.926178] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61442worker # [ 3.424893] hub 3-0:1.0: 2 ports detected1443worker # [ 3.157168] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks1444worker # [ 3.164106] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1445worker # [ 3.443765] uhci_hcd 0000:00:1d.2: UHCI Host Controller1446worker # [ 3.449454] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41447worker # [ 3.455054] uhci_hcd 0000:00:1d.2: detected 2 ports1448worker # [ 3.458050] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2801449worker # [ 3.461848] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1450worker # [ 3.463400] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1451worker # [ 3.190304] systemd[1]: Mounting /sysroot...1452worker # [ 3.469335] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181453hub # [ 11.926590] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51454worker # [ 3.474490] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11455worker # [ 3.477440] ahci 0000:00:1f.2: flags: 64bit ncq only1456worker # [ 3.482840] usb usb4: Product: UHCI Host Controller1457worker # [ 3.492013] scsi host0: ahci1458worker # [ 3.497104] scsi host1: ahci1459worker # [ 3.498010] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1460worker # [ 3.507284] scsi host2: ahci1461worker # [ 3.513761] usb usb4: SerialNumber: 0000:00:1d.21462worker # [ 3.517879] scsi host3: ahci1463worker # [ 3.525850] hub 4-0:1.0: USB hub found1464worker # [ 3.530266] scsi host4: ahci1465worker # [ 3.533821] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001466worker # [ 3.535388] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101467worker # [ 3.537763] hub 4-0:1.0: 2 ports detected1468worker # [ 3.541783] scsi host5: ahci1469worker # [ 3.542595] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11470worker # [ 3.545925] usb 1-1: Product: QEMU USB Tablet1471worker # [ 3.546988] usb 1-1: Manufacturer: QEMU1472worker # [ 3.548884] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11473hub # [ 12.051093] Console: switching to colour frame buffer device 160x501474worker # [ 3.566813] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11475hub # [ 12.350167] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1476worker # [ 3.583986] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11477hub # [ 12.375592] ppdev: user-space parallel port driver1478worker # [ 3.603785] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11479hub # [ 12.411844] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1480hub # [ 12.625874] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1481worker # [ 3.619579] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11482hub # [ 12.231579] dbus-broker-launch[621]: Looking up NSS user entry for 'systemd-timesync'...1483hub # [ 12.423587] dbus-broker-launch[621]: NSS returned no entry for 'systemd-timesync'1484worker # [ 3.624152] EXT4-fs (vda): mounted filesystem 62a6d2cc-f648-41e3-9fda-7669949658e8 r/w with ordered data mode. Quota mode: none.1485hub # [ 12.427429] dbus-broker-launch[621]: Invalid user-name in /nix/store/mqv6vcphdkph28l70d13di8fffgnc2zk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1486hub # [ 12.433930] systemd[1]: Started D-Bus System Message Bus.1487worker # [ 3.357135] systemd[1]: Mounted /sysroot.1488worker # [ 3.636513] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11489hub # [ 12.436995] systemd[1]: Stopped target Host and Network Name Lookups.1490worker # [ 3.361640] systemd[1]: Reached target Initrd Root File System.1491hub # [ 12.439813] nsncd[676]: Oct 06 15:05:40.420 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1492worker # [ 3.366324] systemd[1]: Mounting /sysroot/nix/.ro-store...1493hub # [ 12.444282] systemd[1]: Stopping Host and Network Name Lookups...1494hub # [ 12.445913] systemd[1]: Stopped target User and Group Name Lookups.1495hub # [ 12.448232] systemd[1]: Stopping User and Group Name Lookups...1496worker # [ 3.372176] systemd[1]: Mounting /sysroot/nix/.rw-store...1497hub # [ 12.450639] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1498hub # [ 12.451935] systemd[1]: nscd.service: Deactivated successfully.1499hub # [ 12.453203] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1500hub # [ 12.455713] systemd-logind[622]: Watching system buttons on /dev/input/event2 (Power Button)1501worker # [ 3.657621] hid: raw HID events driver (C) Jiri Kosina1502hub # [ 12.458288] systemd-logind[622]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1503hub # [ 12.461310] systemd-logind[622]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1504worker # [ 3.385977] systemd[1]: Mounting /sysroot/run...1505hub # [ 12.463190] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1506hub # [ 12.464738] dbus-broker-launch[621]: Ready1507hub # [ 12.467723] systemd[1]: Started Name Service Cache Daemon (nsncd).1508worker # [ 3.391206] systemd[1]: Mounting /sysroot/tmp/shared...1509hub # [ 12.469994] systemd[1]: Reached target Host and Network Name Lookups.1510hub # [ 12.472523] systemd[1]: Reached target User and Group Name Lookups.1511worker # [ 3.396177] systemd[1]: Mounting /sysroot/tmp/xchg...1512hub # [ 12.474923] systemd[1]: Finished resolvconf update.1513hub # [ 12.476192] systemd[1]: Reached target Preparation for Network.1514hub # [ 12.477638] systemd[1]: Starting DHCP Client...1515hub # [ 12.480526] systemd-logind[622]: New seat seat0.1516hub # [ 12.481717] systemd[1]: Starting Address configuration of eth1...1517worker # [ 3.408240] systemd[1]: Starting Mountpoints Configured in the Real Root...1518hub # [ 12.486594] systemd[1]: Starting Extra networking commands....1519hub # [ 12.503495] systemd[1]: Starting Tailscale node agent...1520worker # [ 3.430306] systemd[1]: Mounted /sysroot/nix/.rw-store.1521hub # [ 12.512101] systemd[1]: Started User Login Management.1522worker # [ 3.440129] systemd[1]: Mounted /sysroot/run.1523hub # [ 12.520740] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1524worker # [ 3.449263] systemd-sysroot-fstab-check[150]: /sysroot should be mounted in the initrd, will request daemon-reload.1525worker # [ 3.730180] 9p: Installing v9fs 9p2000 file system support1526hub # [ 12.532418] systemd[1]: Stopped Virtual Console Setup.1527worker # [ 3.457810] systemd[1]: Starting rw-sysroot-nix-store.service...1528worker # [ 3.461084] systemd[1]: Reload requested from client PID 150 ('systemd-sysroot') (unit initrd-parse-etc.service)...1529worker # [ 3.463250] systemd[1]: Reloading...1530hub # [ 12.570721] systemd[1]: Starting linger-users.service...1531hub # [ 12.586773] systemd[1]: Starting Virtual Console Setup...1532worker # [ 3.537422] systemd[1]: Reloading finished in 76 ms.1533worker # [ 3.546570] systemd-sysroot-fstab-check[150]: Requesting initrd-fs.target/start/replace...1534worker # [ 3.549980] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1535worker # [ 3.551539] systemd[1]: Finished rw-sysroot-nix-store.service.1536worker # [ 3.554776] systemd-sysroot-fstab-check[150]: Requesting swap.target/start/replace...1537worker # [ 3.558292] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1538hub # [ 12.636477] network-addresses-eth1-start[701]: adding address 192.168.1.1/24... done1539worker # [ 3.560502] systemd[1]: Finished Mountpoints Configured in the Real Root.1540worker # [ 3.562313] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1541worker # [ 3.565957] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1542worker # [ 3.569463] systemd[1]: Starting rw-sysroot-nix-store.service...1543worker # [ 3.580479] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1544worker # [ 3.582654] systemd[1]: Finished rw-sysroot-nix-store.service.1545hub # [ 12.665721] network-addresses-eth1-start[701]: adding address 2001:db8:1::1/64... done1546hub # [ 12.672509] systemd[1]: linger-users.service: Deactivated successfully.1547hub # [ 12.677251] systemd[1]: Finished linger-users.service.1548hub # [ 12.695229] systemd[1]: Finished Address configuration of eth1.1549worker # [ 3.959065] ata1: SATA link down (SStatus 0 SControl 300)1550worker # [ 3.960350] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1551worker # [ 3.961906] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001552worker # [ 3.963096] ata3.00: applying bridge limits1553worker # [ 3.964211] ata2: SATA link down (SStatus 0 SControl 300)1554worker # [ 3.965544] ata4: SATA link down (SStatus 0 SControl 300)1555worker # [ 3.966898] ata5: SATA link down (SStatus 0 SControl 300)1556worker # [ 3.968189] ata6: SATA link down (SStatus 0 SControl 300)1557worker # [ 3.969563] ata3.00: configured for UDMA/1001558worker # [ 3.971105] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51559worker # [ 3.981169] erofs (device vdb): mounted with root inode @ nid 36.1560worker # [ 3.712444] systemd[1]: Mounted /sysroot/tmp/shared.1561worker # [ 3.717181] systemd[1]: Mounted /sysroot/nix/.ro-store.1562worker # [ 3.718558] systemd[1]: Mounted /sysroot/tmp/xchg.1563worker # [ 4.016663] usbcore: registered new interface driver usbhid1564worker # [ 4.020215] usbhid: USB HID core driver1565worker # [ 4.025994] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1566worker # [ 4.028853] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21567worker # [ 4.031250] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01568worker # [ 4.037890] cdrom: Uniform CD-ROM driver Revision: 3.201569hub # [ 12.856431] systemd[1]: Finished Extra networking commands..1570hub # [ 12.860272] systemd[1]: Reached target Network.1571hub # [ 12.875146] systemd[1]: Starting Nginx Web Server...1572hub # [ 12.895519] systemd[1]: Starting Permit User Sessions...1573hub # [ 13.126380] kvm_amd: TSC scaling supported1574hub # [ 13.132400] kvm_amd: Nested Virtualization enabled1575hub # [ 13.136591] kvm_amd: Nested Paging enabled1576hub # [ 13.142912] kvm_amd: LBR virtualization supported1577hub # [ 13.143688] kvm_amd: Virtual VMLOAD VMSAVE supported1578hub # [ 13.154517] kvm_amd: Virtual GIF supported1579hub # [ 12.956068] dhcpcd[742]: dhcpcd-10.3.2 starting1580hub # [ 12.962095] tailscaled[703]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1581hub # [ 12.978285] dhcpcd[785]: dev: loaded udev1582hub # [ 12.994952] systemd[1]: Finished Permit User Sessions.1583hub # [ 13.001661] tailscaled[703]: Program starting: v1.102.3, Go 1.26.7: []string{"/nix/store/lfqbsp1wh59izfbs39sf9yds7dp0jwdj-tailscale-1.102.3/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}1584hub # [ 13.009117] tailscaled[703]: LogID: 45d4811559efd17e6cf450d3fb8114ab932e9cb13d6a7f8cd9bc1d390e07e0fe1585hub # [ 13.011300] tailscaled[703]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1586hub # [ 13.013792] tailscaled[703]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1587hub # [ 13.017296] tailscaled[703]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1588hub # [ 13.025637] systemd[1]: Started Getty on tty1.1589hub # [ 13.027928] systemd[1]: Reached target Login Prompts.1590hub # [ 13.239361] 8021q: 802.1Q VLAN Support v1.81591hub # [ 13.243994] 8021q: adding VLAN 0 to HW filter on device eth11592hub # [ 13.266359] EDAC MC: Ver: 3.0.01593hub # [ 13.097673] tailscaled[703]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:39182->[::1]:53: read: connection refused (in 36ms), trying bootstrap...1594hub # [ 13.103754] systemd-vconsole-setup[711]: Configuration of first virtual console was skipped, ignoring remaining ones.1595hub # [ 13.112924] systemd[1]: Finished Virtual Console Setup.1596hub # [ 13.121788] dbus-broker-launch[621]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.1597hub # [ 13.129590] tailscaled[703]: trying bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" ...1598hub # [ 13.135432] tailscaled[703]: bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.65:443: connect: network is unreachable1599hub # [ 13.138920] tailscaled[703]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ...1600hub # [ 13.141083] tailscaled[703]: bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c]:443: connect: network is unreachable1601hub # [ 13.145197] tailscaled[703]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ...1602hub # [ 13.147043] tailscaled[703]: 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 unreachable1603hub # [ 13.152507] tailscaled[703]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ...1604hub # [ 13.155279] tailscaled[703]: 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 unreachable1605hub # [ 13.161652] tailscaled[703]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ...1606hub # [ 13.164757] tailscaled[703]: 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 unreachable1607hub # [ 13.169684] tailscaled[703]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...1608hub # [ 13.174361] tailscaled[703]: bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2600:1f1e:ee4:5611:ec5c:1736:d43b:a454]:443: connect: network is unreachable1609hub # [ 13.185558] tailscaled[703]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...1610hub # [ 13.189324] tailscaled[703]: 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 unreachable1611hub # [ 13.197254] tailscaled[703]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ...1612hub # [ 13.199893] tailscaled[703]: bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::287]:443: connect: network is unreachable1613hub # [ 13.204597] tailscaled[703]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ...1614hub # [ 13.209971] tailscaled[703]: 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 unreachable1615hub # [ 13.215554] tailscaled[703]: trying bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" ...1616hub # [ 13.221306] tailscaled[703]: bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::ec1:e001]:443: connect: network is unreachable1617hub # [ 13.225954] tailscaled[703]: trying bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" ...1618hub # [ 13.229298] tailscaled[703]: bootstrapDNS("derp4d.tailscale.com", "134.122.94.167") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.94.167:443: connect: network is unreachable1619hub # [ 13.235780] tailscaled[703]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ...1620hub # [ 13.239758] tailscaled[703]: 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 unreachable1621hub # [ 13.256211] tailscaled[703]: logtail: upload: log upload of 468 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/c854c0c3bd5cec07e89ecc35cce3c09b5b0ca2265c59c37970021b8fa0ccf850": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"1622worker # [ 4.190978] systemd[1]: Mounting /sysroot/nix/store...1623worker # [ 4.220155] systemd[1]: Mounted /sysroot/nix/store.1624worker # [ 4.223545] systemd[1]: Reached target Initrd File Systems.1625worker # [ 4.227135] systemd[1]: Starting Find NixOS closure...1626hub # [ 13.308224] tailscaled[703]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1627worker # [ 4.232382] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1628hub # [ 13.312303] tailscaled[703]: dns: using "openresolv" mode1629hub # [ 13.318403] tailscaled[703]: dns: using dns.openresolvManager1630worker # [ 4.261476] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1631worker # [ 4.266151] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1632worker # [ 4.279328] systemd[1]: Finished Find NixOS closure.1633worker # [ 4.281667] systemd[1]: Reached target Initrd Default Target.1634worker # [ 4.284800] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1635hub # [ 13.378574] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1636worker # [ 4.308595] systemd[1]: Stopped target Initrd Default Target.1637worker # [ 4.311064] systemd[1]: Stopped target Basic System.1638worker # [ 4.313506] systemd[1]: Stopped target Initrd Root Device.1639worker # [ 4.315059] systemd[1]: Stopped target Path Units.1640worker # [ 4.316655] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1641worker # [ 4.319900] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1642worker # [ 4.323958] systemd[1]: Stopped target Slice Units.1643worker # [ 4.325882] systemd[1]: Stopped target Socket Units.1644worker # [ 4.329295] systemd[1]: Stopped target System Initialization.1645worker # [ 4.332071] systemd[1]: Stopped target Swaps.1646worker # [ 4.333554] systemd[1]: Stopped target Timer Units.1647worker # [ 4.338830] systemd[1]: dbus.socket: Deactivated successfully.1648worker # [ 4.341269] systemd[1]: Closed D-Bus System Message Bus Socket.1649worker # [ 4.344551] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1650hub # [ 13.630059] cfg80211: Loading compiled-in X.509 certificates for regulatory database1651worker # [ 4.347393] systemd[1]: Stopped Find NixOS closure.1652worker # [ 4.349479] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1653worker # [ 4.354998] systemd[1]: Starting rw-sysroot-nix-store.service...1654worker # [ 4.358226] systemd[1]: systemd-sysctl.service: Deactivated successfully.1655worker # [ 4.362319] systemd[1]: Stopped Apply Kernel Variables.1656worker # [ 4.364800] systemd[1]: systemd-modules-load.service: Deactivated successfully.1657worker # [ 4.369094] systemd[1]: Stopped Load Kernel Modules.1658worker # [ 4.372231] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1659worker # [ 4.374544] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1660worker # [ 4.379509] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1661worker # [ 4.382671] systemd[1]: Stopped Create System Files and Directories.1662worker # [ 4.387378] systemd[1]: Stopped target Local File Systems.1663worker # [ 4.390378] systemd[1]: Stopped target Preparation for Local File Systems.1664worker # [ 4.393952] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1665worker # [ 4.398268] systemd[1]: Stopped Coldplug All udev Devices.1666worker # [ 4.404228] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1667worker # [ 4.407623] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1668worker # [ 4.412856] systemd[1]: Stopped Virtual Console Setup.1669worker # [ 4.443148] systemd[1]: initrd-cleanup.service: Deactivated successfully.1670worker # [ 4.458209] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1671worker # [ 4.465149] systemd[1]: systemd-udevd.service: Deactivated successfully.1672worker # [ 4.468185] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1673worker # [ 4.479289] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1674worker # [ 4.481340] systemd[1]: Finished rw-sysroot-nix-store.service.1675worker # [ 4.488170] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1676worker # [ 4.490106] systemd[1]: Closed udev Control Socket.1677worker # [ 4.492048] systemd[1]: Starting Cleanup udev Database...1678worker # [ 4.494255] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1679worker # [ 4.496351] systemd[1]: Stopped Create Static Device Nodes in /dev.1680worker # [ 4.498248] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1681worker # [ 4.500388] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1682hub # [ 13.787513] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1683worker # [ 4.502564] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1684worker # [ 4.505235] systemd[1]: Stopped Create List of Static Device Nodes.1685hub # [ 13.790580] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1686hub # [ 13.800092] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21687hub # [ 13.801586] cfg80211: failed to load regulatory.db1688worker # [ 4.530835] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1689worker # [ 4.533584] systemd[1]: Finished Cleanup udev Database.1690worker # [ 4.537572] systemd[1]: Reached target Switch Root.1691worker # [ 4.541113] systemd[1]: Starting NixOS Activation...1692hub # [ 13.667187] nginx-pre-start[791]: nginx: the configuration file /nix/store/aqi5a2bf3dl2x51fdyqznmfzaafjr8ns-nginx.conf syntax is ok1693hub # [ 13.671770] nginx-pre-start[791]: nginx: configuration file /nix/store/aqi5a2bf3dl2x51fdyqznmfzaafjr8ns-nginx.conf test is successful1694hub # [ 13.688826] systemd[1]: Started Nginx Web Server.1695worker # [ 4.641791] initrd-nixos-activation-start[206]: booting system configuration /nix/store/nsra6xj5gzd76180dzbn5iyski14kk1h-nixos-system-worker-test1696worker # [ 4.669261] initrd-nixos-activation-start[206]: running activation script...1697hub # [ 13.965605] 8021q: adding VLAN 0 to HW filter on device eth01698hub # [ 13.765334] dhcpcd[785]: eth0: waiting for carrier1699hub # [ 13.767169] dhcpcd[785]: eth0: carrier acquired1700hub # [ 13.791168] dhcpcd[785]: DUID 00:01:00:01:32:57:ca:c5:52:54:00:12:34:561701hub # [ 13.793960] dhcpcd[785]: eth0: IAID 00:12:34:561702hub # [ 13.795855] dhcpcd[785]: eth0: adding address fe80::5054:ff:fe12:34561703worker # [ 4.942342] initrd-nixos-activation-start[229]: setting up /etc...1704hub # [ 14.099981] tailscaled[703]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found1705hub # [ 14.118492] systemd[1]: Started Tailscale node agent.1706hub # [ 14.124369] tailscaled[703]: wgengine.NewUserspaceEngine(tun "tailscale0") ...1707worker # [ 5.067073] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1708worker # [ 5.069952] systemd[1]: Finished NixOS Activation.1709worker # [ 5.074082] systemd[1]: Starting Switch Root...1710worker # [ 5.092925] systemd[1]: Switching root.1711hub # [ 14.386696] tun: Universal TUN/TAP device driver, 1.61712hub # [ 14.192145] (udev-worker)[797]: Network interface NamePolicy= disabled on kernel command line.1713hub # [ 14.273355] tailscaled[703]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]1714hub # [ 14.277380] tailscaled[703]: dns: using "openresolv" mode1715hub # [ 14.296155] tailscaled[703]: dns: using dns.openresolvManager1716hub # [ 14.297996] tailscaled[703]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true}1717worker # [ 5.503045] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1718hub # [ 14.323425] tailscaled[703]: magicsock: disco key = d:ec8b4b0a073251951719hub # [ 14.328723] tailscaled[703]: Creating WireGuard device...1720hub # [ 14.339550] tailscaled[703]: router: portUpdate(port=41641, network=udp6)1721hub # [ 14.345142] tailscaled[703]: router: using firewall mode pref1722hub # [ 14.359664] dhcpcd[785]: eth0: soliciting a DHCP lease1723hub # [ 14.364650] tailscaled[703]: Bringing WireGuard device up...1724hub # [ 14.369561] tailscaled[703]: Bringing router up...1725hub # [ 14.396867] tailscaled[703]: external route: up1726hub # [ 14.617587] NET: Registered PF_PACKET protocol family1727hub # [ 14.418682] dhcpcd[785]: eth0: offered 10.0.2.15 from 10.0.2.21728hub # [ 14.423350] dhcpcd[785]: eth0: probing address 10.0.2.15/241729worker # [ 5.629316] NET: Registered PF_VSOCK protocol family1730hub # [ 14.444803] tailscaled[703]: router: default choosing iptables1731hub # [ 14.519517] tailscaled[703]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true1732hub # [ 14.522714] tailscaled[703]: router: portUpdate(port=41641, network=udp4)1733hub # [ 14.530935] tailscaled[703]: Clearing router settings...1734hub # [ 14.532831] tailscaled[703]: Starting network monitor...1735hub # [ 14.535775] tailscaled[703]: Engine created.1736hub # [ 14.561327] tailscaled[703]: pm: migrating "_daemon" profile to new format1737hub # [ 14.564821] tailscaled[703]: envknob: PORT="41641"1738hub # [ 14.571497] tailscaled[703]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1739hub # [ 14.574532] tailscaled[703]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes1740hub # [ 14.582051] tailscaled[703]: got LocalBackend in 464ms1741hub # [ 14.583947] tailscaled[703]: Start1742hub # [ 14.589094] tailscaled[703]: ipnext: "conn25": skipping extension1743hub # [ 14.593175] tailscaled[703]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop1744hub # [ 14.600916] tailscaled[703]: profile data directory: profile not found1745hub # [ 14.605396] tailscaled[703]: Backend: logs: be:45d4811559efd17e6cf450d3fb8114ab932e9cb13d6a7f8cd9bc1d390e07e0fe fe:1746hub # [ 14.611075] tailscaled[703]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)1747hub # [ 14.613322] tailscaled[703]: blockEngineUpdates(true)1748hub # [ 14.614688] tailscaled[703]: wgengine: Reconfig: configuring router1749hub # [ 14.617388] tailscaled[703]: wgengine: Reconfig: user dialer1750hub # [ 14.619195] tailscaled[703]: wgengine: Reconfig: configuring DNS1751hub # [ 14.621286] tailscaled[703]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1752hub # [ 14.623544] tailscaled[703]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1753hub # [ 14.625834] tailscaled[703]: dns: OScfg: {}1754hub # [ 14.634467] tailscaled[703]: health(warnable=wantrunning-false): error: Tailscale is stopped.1755worker # [ 6.001433] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1756worker # [ 6.011417] systemd[1]: Detected virtualization kvm.1757worker # [ 6.013430] systemd[1]: Detected architecture x86-64.1758worker # [ 6.015684] systemd[1]: Detected first boot.1759worker # [ 6.019385] systemd[1]: Initializing machine ID from random generator.1760worker # [ 6.182347] systemd[1]: bpf-restrict-fs: LSM BPF program attached1761worker # [ 6.383026] systemd[1]: Applying preset policy.1762hub # [ 15.205810] dhcpcd[785]: eth0: soliciting an IPv6 router1763hub # [ 15.208899] dhcpcd[785]: eth0: Router Advertisement from fe80::21764hub # [ 15.212861] dhcpcd[785]: eth0: adding address fec0::5054:ff:fe12:3456/641765hub # [ 15.215307] dhcpcd[785]: eth0: adding route to fec0::/641766hub # [ 15.216920] dhcpcd[785]: eth0: adding default route via fe80::21767hub # [ 15.220954] tailscaled[703]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2541768hub # [ 15.223898] tailscaled[703]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2541769worker # [ 6.498133] systemd[1]: Populated /etc with preset unit settings.1770worker # [ 6.670515] systemd[1]: initrd-switch-root.service: Deactivated successfully.1771worker # [ 6.673377] systemd[1]: Stopped initrd-switch-root.service.1772worker # [ 6.678195] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1773worker # [ 6.682258] systemd[1]: Created slice Slice /system/getty.1774worker # [ 6.684904] systemd[1]: Created slice Slice /system/tribuchet-agent.1775worker # [ 6.687571] systemd[1]: Created slice User and Session Slice.1776worker # [ 6.689306] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1777worker # [ 6.691553] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1778worker # [ 6.693557] systemd[1]: Expecting device /dev/hvc0...1779worker # [ 6.694893] systemd[1]: Expecting device /dev/ttyS0...1780worker # [ 6.696257] systemd[1]: Reached target Local Encrypted Volumes.1781worker # [ 6.697836] systemd[1]: Stopped target initrd-fs.target.1782worker # [ 6.699265] systemd[1]: Stopped target initrd-root-fs.target.1783worker # [ 6.700793] systemd[1]: Stopped target initrd-switch-root.target.1784worker # [ 6.702345] systemd[1]: Reached target Virtual Machines and Containers.1785worker # [ 6.704068] systemd[1]: Reached target Path Units.1786worker # [ 6.705422] systemd[1]: Reached target Remote File Systems.1787worker # [ 6.706946] systemd[1]: Reached target Slice Units.1788worker # [ 6.708272] systemd[1]: Reached target Swaps.1789worker # [ 6.711194] systemd[1]: Listening on Query the User Interactively for a Password.1790worker # [ 6.721161] systemd[1]: Listening on Process Core Dump Socket.1791worker # [ 6.723967] systemd[1]: Listening on Credential Encryption/Decryption.1792worker # [ 6.727143] systemd[1]: Listening on Factory Reset Management.1793worker # [ 6.728962] systemd[1]: Listening on Hostname Service Socket.1794worker # [ 6.733331] systemd[1]: Starting Journal Log Access Socket...1795worker # [ 6.738478] systemd[1]: Listening on Journal Audit Socket.1796worker # [ 6.741532] systemd[1]: Listening on Console Output Muting Service Socket.1797worker # [ 6.743585] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1798worker # [ 6.745683] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1799worker # [ 6.748050] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1800worker # [ 6.752879] systemd[1]: Listening on Disk Repartitioning Service Socket.1801worker # [ 6.754760] systemd[1]: Listening on udev Control Socket.1802worker # [ 6.756288] systemd[1]: Listening on udev Varlink Socket.1803worker # [ 6.760389] systemd[1]: Mounting Huge Pages File System...1804hub # [ 15.551642] tailscaled[703]: 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::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[default-if-changed]1805worker # [ 6.763832] systemd[1]: Mounting POSIX Message Queue File System...1806hub # [ 15.565289] tailscaled[703]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}1807hub # [ 15.568464] tailscaled[703]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}1808hub # [ 15.571058] tailscaled[703]: dns: OScfg: {}1809worker # [ 6.773927] systemd[1]: Mounting Kernel Debug File System...1810worker # [ 6.788917] systemd[1]: Mounting Kernel Trace File System...1811worker # [ 6.806456] systemd[1]: Starting Create List of Static Device Nodes...1812worker # [ 6.813408] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1813worker # [ 6.839955] systemd[1]: Starting Load Kernel Module configfs...1814worker # [ 6.845804] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1815worker # [ 6.857414] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1816worker # [ 6.862944] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1817worker # [ 6.872889] systemd[1]: Mounting FUSE Control File System...1818worker # [ 6.876943] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671819hub # [ 15.689826] tailscaled[703]: wgengine: set DNS config again after major link change1820worker # [ 6.895863] systemd[1]: Starting Journal Service...1821hub # [ 15.693983] tailscaled[703]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64]1822hub # [ 15.697517] tailscaled[703]: magicsock: 0 active derp conns1823hub # [ 15.701254] tailscaled[703]: router: portUpdate(port=41641, network=udp6)1824hub # [ 15.704254] tailscaled[703]: router: portUpdate(port=41641, network=udp4)1825worker # [ 6.906872] systemd[1]: Starting Load Kernel Modules...1826worker # [ 6.913976] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1827worker # [ 6.920894] systemd[1]: Starting Remount Root and Kernel File Systems...1828worker # [ 6.923867] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1829worker # [ 6.933900] systemd[1]: Starting Coldplug All udev Devices...1830worker # [ 6.940616] systemd[1]: Listening on Journal Log Access Socket.1831worker # [ 6.945161] systemd[1]: Mounted Huge Pages File System.1832worker # [ 6.948199] systemd[1]: Mounted POSIX Message Queue File System.1833worker # [ 6.952154] systemd[1]: Mounted Kernel Debug File System.1834worker # [ 6.955834] systemd[1]: Mounted Kernel Trace File System.1835worker # [ 6.961211] systemd[1]: Finished Create List of Static Device Nodes.1836worker # [ 6.965067] systemd[1]: modprobe@configfs.service: Deactivated successfully.1837worker # [ 6.972876] systemd[1]: Finished Load Kernel Module configfs.1838worker # [ 6.977480] systemd[1]: Mounted FUSE Control File System.1839worker # [ 6.986893] systemd[1]: Mounting Kernel Configuration File System...1840worker # [ 7.001929] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1841worker # [ 7.017097] systemd[1]: Mounted Kernel Configuration File System.1842worker # [ 7.061154] EXT4-fs (vda): re-mounted 62a6d2cc-f648-41e3-9fda-7669949658e8.1843worker # [ 7.069952] loop: module loaded1844worker # [ 7.077004] systemd[1]: Finished Remount Root and Kernel File Systems.1845worker # [ 7.080809] systemd-journald[300]: Collecting audit messages is enabled.1846worker # [ 7.082475] systemd[1]: Listening on Disk Image Download Service Socket.1847worker # [ 7.084996] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1848worker # [ 7.101136] systemd[1]: Starting Load/Save OS Random Seed...1849worker # [ 7.106001] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1850worker # [ 7.119629] systemd[1]: Finished Load Kernel Modules.1851worker # [ 7.137660] systemd[1]: Starting Firewall...1852worker # [ 7.153957] systemd[1]: Starting Apply Kernel Variables...1853worker # [ 7.231172] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1854worker # [ 7.241896] systemd[1]: Starting Create Static Device Nodes in /dev...1855worker # [ 7.278490] systemd[1]: Finished Load/Save OS Random Seed.1856worker # [ 7.282762] systemd[1]: Reached target First Boot Complete.1857worker # [ 7.291154] systemd[1]: Started Journal Service.1858worker # [ 7.017754] systemd[1]: Queued start job for default target Multi-User System.1859worker # [ 7.028367] systemd[1]: Unnecessary job was removed for /dev/vdb.1860worker # [ 7.044636] systemd[1]: systemd-journald.service: Deactivated successfully.1861worker # [ 7.059403] systemd-modules-load[301]: Inserted module 'loop'1862worker # [ 7.067380] systemd[1]: Starting Flush Journal to Persistent Storage...1863worker # [ 7.078260] systemd[1]: Finished Apply Kernel Variables.1864worker # [ 7.156510] systemd-oomd[302]: No swap; memory pressure usage will be degraded1865worker # [ 7.163649] systemd[1]: Finished Create Static Device Nodes in /dev.1866worker # [ 7.173674] systemd[1]: Reached target Preparation for Local File Systems.1867worker # [ 7.175757] systemd[1]: Starting Rule-based Manager for Device Events and Files...1868worker # [ 7.458297] systemd-journald[300]: Received client request to flush runtime journal.1869hub # [ 16.433106] tailscaled[703]: monitor: RTM_NEWROUTE: src=, dst=fec0::47a4:7643:862b:39a/128, gw=, outif=2, table=2551870worker # [ 7.625531] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1871worker # [ 7.647142] systemd-udevd[333]: Using default interface naming scheme 'v261'.1872worker # [ 7.659965] systemd[1]: Mounting /run/wrappers...1873worker # [ 7.670223] systemd[1]: Mounted /run/wrappers.1874worker # [ 7.678150] systemd[1]: Reached target Local File Systems.1875worker # [ 7.691241] systemd[1]: Listening on Boot Loader Control Service Socket.1876worker # [ 7.699162] systemd[1]: Starting register-nix-paths.service...1877worker # [ 7.703189] systemd[1]: Starting Create SUID/SGID Wrappers...1878worker # [ 7.707429] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1879worker # [ 7.716986] systemd[1]: Starting Save Transient machine-id to Disk...1880worker # [ 7.722934] systemd[1]: Started Rule-based Manager for Device Events and Files.1881worker # [ 7.728967] systemd[1]: Finished Flush Journal to Persistent Storage.1882worker # [ 7.730896] systemd[1]: Starting Create System Files and Directories...1883worker # [ 7.740357] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1884worker # [ 7.748226] systemd[1]: Finished Save Transient machine-id to Disk.1885worker # [ 7.854514] systemd[1]: Finished Create System Files and Directories.1886worker # [ 7.866151] systemd[1]: Starting Rebuild Journal Catalog...1887worker # [ 7.875180] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1888worker # [ 7.891556] systemd[1]: Finished Coldplug All udev Devices.1889worker # [ 7.992616] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1890worker # [ 8.068149] systemd[1]: Finished Rebuild Journal Catalog.1891worker # [ 8.072239] systemd[1]: Starting Update is Completed...1892hub # [ 17.198588] tailscaled[703]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2551893worker # [ 8.182188] systemd[1]: Finished Update is Completed.1894worker # [ 8.384794] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1895worker # [ 8.387348] systemd[1]: Finished Create SUID/SGID Wrappers.1896worker # [ 8.494684] systemd[1]: Finished Firewall.1897worker # [ 8.503161] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1898worker # [ 8.682186] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1899worker # [ 8.752181] systemd[1]: Finished register-nix-paths.service.1900worker # [ 8.755307] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1901worker # [ 8.759578] systemd[1]: Reached target System Initialization.1902worker # [ 8.763420] systemd[1]: Started Discard unused filesystem blocks once a week.1903worker # [ 8.767752] systemd[1]: Started Daily Cleanup of Temporary Directories.1904worker # [ 8.771424] systemd[1]: Reached target Timer Units.1905worker # [ 8.778413] systemd[1]: Listening on D-Bus System Message Bus Socket.1906worker # [ 8.780200] systemd[1]: Listening on Nix Daemon Socket.1907worker # [ 8.785408] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1908worker # [ 8.790488] systemd[1]: Listening on tribuchet build agent 1 socket.1909worker # [ 8.797577] systemd[1]: Reached target Socket Units.1910worker # [ 8.802407] systemd[1]: Reached target Basic System.1911worker # [ 8.811360] systemd[1]: Started backdoor.service.1912worker # [ 8.817336] systemd[1]: Starting Import lastlog data into lastlog2 database...1913worker # [ 8.826487] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1914worker # [ 8.828590] systemd[1]: Starting Post-Boot Actions...1915worker # [ 8.836279] systemd[1]: Started Reset console on configuration changes.1916worker # [ 8.839440] systemd[1]: Starting resolvconf update...1917worker # [ 8.850194] systemd[1]: Starting D-Bus System Message Bus...1918worker # [ 8.864301] (udev-worker)[399]: Network interface NamePolicy= disabled on kernel command line.1919worker # [ 8.896304] (udev-worker)[396]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1920worker # [ 8.899910] (udev-worker)[396]: Network interface NamePolicy= disabled on kernel command line.1921worker # [ 8.931797] systemd[1]: Finished Post-Boot Actions.1922worker # connecting to host...1923worker # [ 8.997451] nsncd[522]: Oct 06 15:05:46.554 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1924worker # [ 9.001940] systemd[1]: Started Name Service Cache Daemon (nsncd).1925worker # [ 9.009964] systemd[1]: Reached target Host and Network Name Lookups.1926worker # [ 9.014792] systemd[1]: Reached target User and Group Name Lookups.1927worker # [ 9.023624] systemd[1]: Starting User Login Management...1928worker # [ 9.028512] systemd[1]: Finished Import lastlog data into lastlog2 database.1929worker # [ 9.067329] dbus-broker-launch[526]: Looking up NSS user entry for 'systemd-timesync'...1930worker # [ 9.071429] dbus-broker-launch[526]: NSS returned no entry for 'systemd-timesync'1931worker # [ 9.075258] dbus-broker-launch[526]: Invalid user-name in /nix/store/nkryg6dddq5lj7jiizsr32di8m77nkgv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1932worker # [ 9.087113] systemd[1]: Started D-Bus System Message Bus.1933worker # [ 9.124812] dbus-broker-launch[526]: Ready1934worker # [ 9.179721] systemd[1]: Stopped target Host and Network Name Lookups.1935worker # [ 9.181322] systemd[1]: Stopping Host and Network Name Lookups...1936worker # [ 9.182875] systemd[1]: Stopped target User and Group Name Lookups.1937worker # [ 9.189354] systemd[1]: Stopping User and Group Name Lookups...1938worker # [ 9.191948] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1939worker # [ 9.196962] systemd[1]: nscd.service: Deactivated successfully.1940worker # [ 9.202776] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1941worker # [ 9.206932] systemd[1]: nscd.service: Consumed 23ms CPU time over 410ms wall clock time, 6.9M memory peak, 5.6M read from disk.1942worker # [ 9.214890] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1943worker # [ 9.222704] systemd-logind[549]: New seat seat0.1944worker # [ 9.227793] systemd[1]: Started User Login Management.1945worker # [ 9.233572] systemd[1]: Starting linger-users.service...1946worker # [ 9.264171] systemd[1]: Condition check resulted in Virtio network device being skipped.1947worker # [ 9.285277] systemd[1]: Started Name Service Cache Daemon (nsncd).1948worker # [ 9.286749] systemd[1]: Reached target Host and Network Name Lookups.1949worker # [ 9.288256] systemd[1]: Reached target User and Group Name Lookups.1950worker # [ 9.292885] nsncd[599]: Oct 06 15:05:46.856 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1951worker # [ 9.302156] systemd[1]: linger-users.service: Deactivated successfully.1952worker # [ 9.304270] systemd[1]: Finished linger-users.service.1953worker # [ 9.317407] systemd[1]: Finished resolvconf update.1954worker # [ 9.320443] systemd[1]: Reached target Preparation for Network.1955worker # [ 9.324503] systemd[1]: Starting DHCP Client...1956worker # [ 9.332784] systemd[1]: Starting Address configuration of eth1...1957worker # [ 9.337544] systemd[1]: Starting Extra networking commands....1958worker # [ 9.342223] systemd[1]: Starting Tailscale node agent...1959worker # [ 9.449396] network-addresses-eth1-start[627]: adding address 192.168.1.2/24... done1960worker # [ 9.474113] network-addresses-eth1-start[627]: adding address 2001:db8:1::2/64... done1961worker # [ 9.493584] systemd[1]: Finished Address configuration of eth1.1962worker # [ 9.676476] dhcpcd[642]: dhcpcd-10.3.2 starting1963worker # [ 9.686837] dhcpcd[697]: dev: loaded udev1964worker # [ 9.970780] 8021q: 802.1Q VLAN Support v1.81965worker # [ 9.974642] 8021q: adding VLAN 0 to HW filter on device eth11966worker # [ 9.703313] systemd[1]: Finished Extra networking commands..1967worker # [ 9.706152] systemd[1]: Reached target Network.1968worker # [ 9.714855] systemd[1]: Starting Permit User Sessions...1969worker # [ 9.794869] tailscaled[629]: TPM: error opening: stat /dev/tpmrm0: no such file or directory1970worker # [ 9.810570] systemd[1]: Finished Permit User Sessions.1971worker # [ 9.819105] tailscaled[629]: Program starting: v1.102.3, Go 1.26.7: []string{"/nix/store/lfqbsp1wh59izfbs39sf9yds7dp0jwdj-tailscale-1.102.3/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"}1972worker # [ 9.823557] tailscaled[629]: LogID: 6cfbf59580034429071193f1ab50ea2a76593d0daf6fa1cf296fbb0eab8812341973worker # [ 9.825269] tailscaled[629]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"1974worker # [ 9.830166] tailscaled[629]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory1975worker # [ 9.834205] tailscaled[629]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil1976worker # [ 9.853177] tailscaled[629]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:58485->[::1]:53: read: connection refused (in 11ms), trying bootstrap...1977worker # [ 9.865884] tailscaled[629]: trying bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" ...1978worker # [ 9.873098] tailscaled[629]: bootstrapDNS("derp12c.tailscale.com", "149.28.119.105") for "log.tailscale.com" error: Get "https://derp12c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 149.28.119.105:443: connect: network is unreachable1979worker # [ 9.879092] tailscaled[629]: trying bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" ...1980worker # [ 9.881499] tailscaled[629]: bootstrapDNS("derp8b.tailscale.com", "2a03:b0c0:1:d0::ec1:e001") for "log.tailscale.com" error: Get "https://derp8b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::ec1:e001]:443: connect: network is unreachable1981worker # [ 9.889163] tailscaled[629]: trying bootstrapDNS("derp3.tailscale.com", "68.183.179.66") for "log.tailscale.com" ...1982worker # [ 9.891479] tailscaled[629]: 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 unreachable1983worker # [ 9.895236] tailscaled[629]: trying bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" ...1984worker # [ 10.177402] cfg80211: Loading compiled-in X.509 certificates for regulatory database1985worker # [ 10.184553] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1986worker # [ 9.909363] tailscaled[629]: bootstrapDNS("derp4d.tailscale.com", "2a03:b0c0:3:d0::1501:b001") for "log.tailscale.com" error: Get "https://derp4d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::1501:b001]:443: connect: network is unreachable1987worker # [ 10.191884] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1988worker # [ 9.917123] tailscaled[629]: trying bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" ...1989worker # [ 9.919231] tailscaled[629]: bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" error: Get "https://derp9c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 155.138.243.219:443: connect: network is unreachable1990worker # [ 10.199998] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21991worker # [ 10.203854] cfg80211: failed to load regulatory.db1992worker # [ 9.929891] tailscaled[629]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ...1993worker # [ 9.932296] tailscaled[629]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable1994worker # [ 9.936885] tailscaled[629]: trying bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" ...1995worker # [ 9.941869] tailscaled[629]: bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.77.138:443: connect: network is unreachable1996worker # [ 9.947246] systemd[1]: Started Getty on tty1.1997worker # [ 9.951302] tailscaled[629]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ...1998worker # [ 9.953930] tailscaled[629]: 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 unreachable1999worker # [ 9.958311] tailscaled[629]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ...2000worker # [ 9.961826] tailscaled[629]: 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 unreachable2001worker # [ 9.966909] tailscaled[629]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ...2002worker # [ 9.970134] tailscaled[629]: bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::f4]:443: connect: network is unreachable2003worker # [ 9.974308] tailscaled[629]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ...2004worker # [ 9.977274] tailscaled[629]: bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.74.153:443: connect: network is unreachable2005worker # [ 9.981644] tailscaled[629]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ...2006worker # [ 9.983883] tailscaled[629]: bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2600:1f1e:ee4:5611:ec5c:1736:d43b:a454]:443: connect: network is unreachable2007worker # [ 9.988224] tailscaled[629]: logtail: upload: log upload of 467 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/2070cf4c630f72922683d28dac32af0d5070bb17233ffb1094f84e9554010e64": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com"2008worker # [ 9.995198] systemd[1]: Reached target Login Prompts.2009worker # [ 9.996437] dbus-broker-launch[526]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found.2010worker # [ 10.011086] tailscaled[629]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]2011worker # [ 10.013143] tailscaled[629]: dns: using "openresolv" mode2012worker # [ 10.014251] tailscaled[629]: dns: using dns.openresolvManager2013worker # [ 10.308999] 8021q: adding VLAN 0 to HW filter on device eth02014worker # [ 10.037203] dhcpcd[697]: eth0: waiting for carrier2015worker # [ 10.038462] dhcpcd[697]: eth0: carrier acquired2016worker # [ 10.320515] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input32017worker # [ 10.047240] dhcpcd[697]: DUID 00:01:00:01:32:57:ca:cb:52:54:00:12:34:562018worker # [ 10.048630] dhcpcd[697]: eth0: IAID 00:12:34:562019worker # [ 10.049855] dhcpcd[697]: eth0: adding address fe80::5054:ff:fe12:34562020worker # [ 10.348496] mousedev: PS/2 mouse device common for all mice2021worker # [ 10.075111] dhcpcd[697]: eth0: soliciting a DHCP lease2022worker # [ 10.356411] NET: Registered PF_PACKET protocol family2023worker # [ 10.360497] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console2024worker # [ 10.088626] dhcpcd[697]: eth0: offered 10.0.2.15 from 10.0.2.22025worker # [ 10.090272] dhcpcd[697]: eth0: probing address 10.0.2.15/242026worker # [ 10.385911] ACPI: button: Power Button [PWRF]2027worker # [ 10.142208] tailscaled[629]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found2028worker # [ 10.150217] systemd[1]: Started Tailscale node agent.2029worker # [ 10.153234] tailscaled[629]: wgengine.NewUserspaceEngine(tun "tailscale0") ...2030worker # [ 10.432931] tun: Universal TUN/TAP device driver, 1.62031worker # [ 10.183950] tailscaled[629]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv]2032worker # [ 10.186084] tailscaled[629]: dns: using "openresolv" mode2033worker # [ 10.195098] tailscaled[629]: dns: using dns.openresolvManager2034worker # [ 10.196335] tailscaled[629]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true}2035worker # [ 10.202471] tailscaled[629]: magicsock: disco key = d:81e7f2652ac5aefc2036worker # [ 10.204261] tailscaled[629]: Creating WireGuard device...2037worker # [ 10.206226] tailscaled[629]: Bringing WireGuard device up...2038worker # [ 10.207827] tailscaled[629]: Bringing router up...2039worker # [ 10.209112] tailscaled[629]: router: using firewall mode pref2040worker # [ 10.225162] tailscaled[629]: external route: up2041worker # [ 10.450091] Console: switching to colour dummy device 80x252042worker # [ 10.510956] [drm] Found bochs VGA, ID 0xb0c5.2043worker # [ 10.510958] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.2044worker # [ 10.237256] tailscaled[629]: router: portUpdate(port=41641, network=udp6)2045worker # [ 10.246623] tailscaled[629]: router: default choosing iptables2046worker # [ 10.529813] rtc_cmos 00:04: RTC can wake from S42047worker # [ 10.263258] tailscaled[629]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true2048worker # [ 10.269073] tailscaled[629]: Clearing router settings...2049worker # [ 10.270244] tailscaled[629]: Starting network monitor...2050worker # [ 10.272223] tailscaled[629]: Engine created.2051hub # [ 19.349799] dhcpcd[785]: eth0: leased 10.0.2.15 for 86400 seconds2052hub # [ 19.351213] dhcpcd[785]: eth0: adding route to 10.0.2.0/242053worker # [ 10.275354] tailscaled[629]: router: portUpdate(port=41641, network=udp4)2054worker # [ 10.553531] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic2055hub # [ 19.354275] dhcpcd[785]: eth0: adding default route via 10.0.2.22056worker # [ 10.554564] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 02057hub # [ 19.356099] tailscaled[703]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552058worker # [ 10.281472] tailscaled[629]: pm: migrating "_daemon" profile to new format2059hub # [ 19.358414] tailscaled[703]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552060worker # [ 10.283419] tailscaled[629]: envknob: PORT="41641"2061hub # [ 19.360416] tailscaled[703]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542062worker # [ 10.285613] tailscaled[629]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale"2063hub # [ 19.363077] tailscaled[703]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542064worker # [ 10.287768] tailscaled[629]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes2065worker # [ 10.293943] tailscaled[629]: got LocalBackend in 145ms2066worker # [ 10.297092] tailscaled[629]: Start2067hub # [ 19.365885] tailscaled[703]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64] rebind-reason=[ips-changed]2068worker # [ 10.297959] tailscaled[629]: ipnext: "conn25": skipping extension2069worker # [ 10.299460] tailscaled[629]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop2070worker # [ 10.306873] tailscaled[629]: profile data directory: profile not found2071hub # [ 19.383383] tailscaled[703]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2072hub # [ 19.385647] tailscaled[703]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2073worker # [ 10.309335] tailscaled[629]: Backend: logs: be:6cfbf59580034429071193f1ab50ea2a76593d0daf6fa1cf296fbb0eab881234 fe:2074hub # [ 19.387504] tailscaled[703]: dns: OScfg: {}2075worker # [ 10.312737] tailscaled[629]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)2076worker # [ 10.314789] tailscaled[629]: blockEngineUpdates(true)2077worker # [ 10.317213] tailscaled[629]: wgengine: Reconfig: configuring router2078worker # [ 10.320976] tailscaled[629]: wgengine: Reconfig: user dialer2079worker # [ 10.600036] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input42080worker # [ 10.325541] tailscaled[629]: wgengine: Reconfig: configuring DNS2081worker # [ 10.326769] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2082worker # [ 10.328353] tailscaled[629]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2083worker # [ 10.331086] tailscaled[629]: dns: OScfg: {}2084worker # [ 10.615779] parport_pc 00:02: reported by Plug and Play ACPI2085worker # [ 10.616657] parport0: PC-style at 0x378, irq 72086worker # [ 10.621242] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized2087worker # [ 10.627781] rtc_cmos 00:04: registered as rtc02088worker # [ 10.628632] rtc_cmos 00:04: setting system clock to 2026-10-06T15:05:47 UTC (1791299147)2089worker # [ 10.631724] systemd-journald[300]: Time jumped backwards, rotating.2090worker # [ 10.658390] [PCSPP(,...)]2091worker # [ 10.663801] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs2092hub # [ 19.464622] systemd[1]: Started DHCP Client.2093hub # [ 19.467925] systemd[1]: Reached target Network is Online.2094hub # [ 19.472783] systemd[1]: Started headscale coordination server for Tailscale.2095worker # [ 10.397207] tailscaled[629]: health(warnable=wantrunning-false): error: Tailscale is stopped.2096hub # [ 19.475201] systemd[1]: Reached target Multi-User System.2097hub # [ 19.477867] systemd[1]: Startup finished in 1.129s (kernel) + 5.180s (initrd) + 13.167s (userspace) = 19.477s.2098worker # [ 10.717042] Console: switching to colour frame buffer device 160x502099worker # [ 10.723703] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device2100worker # [ 10.788343] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt2101worker # [ 10.789305] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD2102worker # [ 10.828920] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input62103worker # [ 10.830525] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input52104worker # [ 10.581526] systemd[1]: Starting Virtual Console Setup...2105worker # [ 10.622683] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2106worker # [ 10.647856] systemd-vconsole-setup[779]: Configuration of first virtual console was skipped, ignoring remaining ones.2107worker # [ 10.654712] systemd[1]: Finished Virtual Console Setup.2108worker # [ 10.672174] (udev-worker)[768]: Network interface NamePolicy= disabled on kernel command line.2109worker # [ 10.681445] systemd-logind[549]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)2110worker # [ 10.705703] systemd-logind[549]: Watching system buttons on /dev/input/event2 (Power Button)2111worker # [ 10.708950] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2112worker # [ 10.711390] systemd[1]: Stopped Virtual Console Setup.2113worker # [ 10.713980] systemd[1]: Stopping Virtual Console Setup...2114worker # [ 10.716742] systemd[1]: Starting Virtual Console Setup...2115worker # [ 10.757222] systemd-vconsole-setup[785]: Configuration of first virtual console was skipped, ignoring remaining ones.2116worker # [ 10.764117] systemd[1]: Finished Virtual Console Setup.2117worker # [ 11.051084] ppdev: user-space parallel port driver2118worker # [ 11.053375] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)2119hub # [ 19.857299] headscale-start[992]: 2026-10-06T15:05:47Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key2120hub # [ 19.867138] headscale-start[992]: 2026-10-06T15:05:47Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite2121worker # [ 10.800097] systemd-logind[549]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2122worker # [ 11.083784] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0)2123worker # [ 10.817185] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2124worker # [ 10.819492] systemd[1]: Stopped Virtual Console Setup.2125worker # [ 10.821686] systemd[1]: Stopping Virtual Console Setup...2126worker # [ 10.824341] systemd[1]: Starting Virtual Console Setup...2127hub # [ 19.933192] headscale-start[992]: 2026-10-06T15:05:47Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key2128worker # [ 10.861821] systemd-vconsole-setup[790]: Configuration of first virtual console was skipped, ignoring remaining ones.2129hub # [ 19.940895] headscale-start[992]: 2026-10-06T15:05:47Z INF starting headscale commit=v0.29.3 version=0.29.32130hub # [ 19.942737] headscale-start[992]: 2026-10-06T15:05:47Z INF Clients with a lower minimum version will be rejected minimum_version=v1.802131worker # [ 10.866650] systemd[1]: Finished Virtual Console Setup.2132hub # [ 19.948263] headscale-start[992]: 2026-10-06T15:05:47Z 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:[0x637e0e52120]}2133hub # [ 19.953129] headscale-start[992]: 2026-10-06T15:05:47Z 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}2134hub # [ 19.970210] headscale-start[992]: 2026-10-06T15:05:47Z INF stun server started at [::]:34782135hub # [ 19.972632] headscale-start[992]: 2026-10-06T15:05:48Z INF HA subnet router health probing enabled interval=10000 timeout=50002136hub # [ 19.983955] headscale-start[992]: 2026-10-06T15:05:48Z WRN listening without TLS but ServerURL does not start with http://2137hub # [ 19.988081] headscale-start[992]: 2026-10-06T15:05:48Z INF listening and serving HTTP on: 127.0.0.1:80802138hub # [ 19.990386] headscale-start[992]: 2026-10-06T15:05:48Z INF metrics server disabled (metrics_listen_addr is empty)2139worker # [ 11.216551] kvm_amd: TSC scaling supported2140worker # [ 11.217402] kvm_amd: Nested Virtualization enabled2141worker # [ 11.218631] kvm_amd: Nested Paging enabled2142worker # [ 11.219481] kvm_amd: LBR virtualization supported2143worker # [ 11.220317] kvm_amd: Virtual VMLOAD VMSAVE supported2144worker # [ 11.221143] kvm_amd: Virtual GIF supported2145worker # [ 11.244148] EDAC MC: Ver: 3.0.02146hub: (finished: waiting for unit headscale, in 12.39 seconds)2147hub: waiting for TCP port 443 on localhost2148hub # Connection to localhost (::1) 443 port [tcp/https] succeeded!2149hub: (finished: waiting for TCP port 443 on localhost, in 0.05 seconds)2150hub: waiting for unit tailscaled2151hub: (finished: waiting for unit tailscaled, in 0.03 seconds)2152worker: waiting for unit tailscaled2153worker: waiting for the VM to finish booting2154worker: Guest shell says: b'Spawning backdoor root shell...\n'2155worker: connected to guest root shell2156worker: (connecting took 0.00 seconds)2157worker: (finished: waiting for the VM to finish booting, in 0.00 seconds)2158worker: (finished: waiting for unit tailscaled, in 0.01 seconds)2159hub: must succeed: headscale users create test2160hub # [ 20.442339] tailscaled[703]: wgengine: set DNS config again after major link change2161hub # [ 20.444330] tailscaled[703]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::47a4:7643:862b:39a/64 fec0::5054:ff:fe12:3456/64]2162hub # [ 20.447486] tailscaled[703]: magicsock: 0 active derp conns2163hub # [ 20.451095] tailscaled[703]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152164hub # [ 20.456110] tailscaled[703]: router: portUpdate(port=41641, network=udp6)2165hub # [ 20.459130] tailscaled[703]: router: portUpdate(port=41641, network=udp4)2166hub # [ 20.460418] tailscaled[703]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2167hub # [ 20.483706] headscale-start[992]: 2026-10-06T15:05:48Z INF user created user.name=test2168hub: (finished: must succeed: headscale users create test, in 0.09 seconds)2169hub: must succeed: headscale preauthkeys -u 1 create --reusable2170hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.10 seconds)2171hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ey9lVlBhVvzM-aJp9aSB6Xwzt4eNl4G3gfbej9-2s44irmG4wetheDHzZX902STMiGleLZXHnZhlz --hostname hub2172hub # [ 20.632089] tailscaled[703]: localapi: [POST] /localapi/v0/check-prefs2173hub # [ 20.634982] tailscaled[703]: localapi: [POST] /localapi/v0/start2174hub # [ 20.636595] tailscaled[703]: control: client.Shutdown ...2175hub # [ 20.638190] tailscaled[703]: control: updateRoutine: exiting2176hub # [ 20.639543] tailscaled[703]: control: authRoutine: exiting2177hub # [ 20.641190] tailscaled[703]: control: mapRoutine: exiting2178hub # [ 20.642774] tailscaled[703]: control: Client.Shutdown done.2179hub # [ 20.644483] tailscaled[703]: Start2180hub # [ 20.646288] tailscaled[703]: 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]2181hub # [ 20.649819] tailscaled[703]: generating new machine key2182hub # [ 20.653824] tailscaled[703]: machine key written to store2183hub # [ 20.654894] tailscaled[703]: profile data directory: profile not found2184hub # [ 20.656348] tailscaled[703]: Backend: logs: be:45d4811559efd17e6cf450d3fb8114ab932e9cb13d6a7f8cd9bc1d390e07e0fe fe:2185hub # [ 20.662112] tailscaled[703]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2186hub # [ 20.664095] tailscaled[703]: blockEngineUpdates(true)2187hub # [ 20.665576] tailscaled[703]: Reconfig(down): no changes made to Engine config2188hub # [ 20.667798] tailscaled[703]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2189hub # [ 20.670174] tailscaled[703]: health(warnable=wantrunning-false): ok2190hub # [ 20.672252] tailscaled[703]: localapi: [POST] /localapi/v0/login-interactive2191hub # [ 20.673783] tailscaled[703]: StartLoginInteractiveAs("root"): url=false2192hub # [ 20.675318] tailscaled[703]: control: client.Login(2)2193hub # [ 20.678954] tailscaled[703]: control: LoginInteractive -> regen=true2194hub # [ 20.680322] tailscaled[703]: control: doLogin(regen=true, hasUrl=false)2195hub # [ 20.745404] tailscaled[703]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2196hub # [ 20.756923] headscale-start[992]: 2026-10-06T15:05:48Z INF http request bytes=176 elapsed=1.654959 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:35676 status=2002197hub # [ 20.762853] tailscaled[703]: control: control server key from https://hub: ts2021=[cfmur], legacy=2198hub # [ 20.765303] tailscaled[703]: control: Generating a new nodekey.2199hub # [ 20.768683] tailscaled[703]: control: RegisterReq: onode= node=[tMjhf] fup=false nks=false2200worker # [ 11.820481] dhcpcd[697]: eth0: soliciting an IPv6 router2201worker # [ 11.822808] dhcpcd[697]: eth0: Router Advertisement from fe80::22202worker # [ 11.824662] dhcpcd[697]: eth0: adding address fec0::5054:ff:fe12:3456/642203worker # [ 11.826651] dhcpcd[697]: eth0: adding route to fec0::/642204worker # [ 11.828111] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=2542205worker # [ 11.829867] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=2542206worker # [ 11.831522] dhcpcd[697]: eth0: adding default route via fe80::22207worker # [ 12.296190] tailscaled[629]: 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::bd1a:c289:7db8:9808/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::bd1a:c289:7db8:9808/64] rebind-reason=[default-if-changed]2208worker # [ 12.303569] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2209worker # [ 12.305160] tailscaled[629]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2210worker # [ 12.307288] tailscaled[629]: dns: OScfg: {}2211worker # [ 12.318330] tailscaled[629]: wgengine: set DNS config again after major link change2212worker # [ 12.320818] tailscaled[629]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::bd1a:c289:7db8:9808/64]2213worker # [ 12.323508] tailscaled[629]: magicsock: 0 active derp conns2214worker # [ 12.325147] tailscaled[629]: router: portUpdate(port=41641, network=udp6)2215worker # [ 12.326790] tailscaled[629]: router: portUpdate(port=41641, network=udp4)2216hub # [ 21.453398] headscale-start[992]: 2026-10-06T15:05:49Z INF http request bytes=249 elapsed=666.135221 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:35688 status=2002217hub # [ 21.457318] tailscaled[703]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2218hub # [ 21.461834] tailscaled[703]: blockEngineUpdates(false)2219hub # [ 21.955376] headscale-start[992]: 2026-10-06T15:05:49Z INF http request bytes=0 elapsed=493.454336 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35688 status=2002220worker # [ 13.206110] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=2552221worker # [ 13.208107] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=fec0::bd1a:c289:7db8:9808/128, gw=, outif=2, table=2552222hub # [ 22.454424] headscale-start[992]: 2026-10-06T15:05:50Z INF node connected machine.key=[M8EK+] node.expired=false node.id=1 node.is_tagged=false node.key=[tMjhf] node.name=hub node.online=true user.name=test2223hub # [ 22.459097] headscale-start[992]: 2026-10-06T15:05:50Z INF github.com/juanfont/headscale/hscontrol/poll.go:250 > node has connected chan=0x637e0baaa10 component=poll machine.key=[M8EK+] node.expired=false node.id=1 node.is_tagged=false node.key=[tMjhf] node.name=hub node.online=false omit_peers=false stream=true user.name=test2224hub # [ 22.496517] tailscaled[703]: magicsock: new contact: control-netmap usec=8193975 cached=false2225hub # [ 22.498939] tailscaled[703]: active login: test2226hub # [ 22.506108] tailscaled[703]: netmap: suggested exit node: no preferred DERP, try again later2227hub # [ 22.507847] tailscaled[703]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2228hub # [ 22.510634] tailscaled[703]: magicsock: SetPrivateKey called (init)2229hub # [ 22.512343] tailscaled[703]: wgengine: Reconfig: configuring router2230hub # [ 22.756109] tailscaled[703]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [10ms] (forced=false)2231hub # [ 22.757955] tailscaled[703]: magicsock: home is now derp-999 ()2232hub # [ 22.760087] tailscaled[703]: magicsock: adding connection to derp-999 for home-keep-alive2233hub # [ 22.762140] tailscaled[703]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2234hub # [ 22.764340] tailscaled[703]: derphttp.Client.Connect: connecting to derp-999 ()2235hub # [ 22.767645] tailscaled[703]: 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::47a4:7643:862b:39a]:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local)2236hub # [ 22.776078] tailscaled[703]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2237hub # [ 22.789195] tailscaled[703]: magicsock: derp-999 connected; connGen=12238hub # [ 22.809647] tailscaled[703]: router: enabling connmark-based rp_filter workaround2239hub # [ 22.877947] tailscaled[703]: wgengine: Reconfig: user dialer2240hub # [ 22.879640] tailscaled[703]: tsdial: bart table size: 22241hub # [ 22.880654] tailscaled[703]: wgengine: Reconfig: configuring DNS2242hub # [ 22.882074] tailscaled[703]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2243hub # [ 22.915519] tailscaled[703]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2244hub # [ 22.917785] tailscaled[703]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2245hub # [ 22.971296] systemd[1]: Stopped target Host and Network Name Lookups.2246hub # [ 22.972918] systemd[1]: Stopping Host and Network Name Lookups...2247hub # [ 22.974769] systemd[1]: Stopped target User and Group Name Lookups.2248hub # [ 22.977369] systemd[1]: Stopping User and Group Name Lookups...2249hub # [ 22.979194] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2250hub # [ 22.982086] systemd[1]: nscd.service: Deactivated successfully.2251hub # [ 22.985086] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2252hub # [ 22.992456] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2253hub # [ 23.018407] tailscaled[703]: peerapi: serving on http://100.64.0.1:584362254hub # [ 23.021212] tailscaled[703]: peerapi: serving on http://[fd7a:115c:a1e0::1]:597802255hub # [ 23.025243] tailscaled[703]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2256hub # [ 23.030260] tailscaled[703]: updating netmap in disk cache2257hub # [ 23.038256] systemd[1]: Started Name Service Cache Daemon (nsncd).2258hub # [ 23.039700] tailscaled[703]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2259hub # [ 23.041383] systemd[1]: Reached target Host and Network Name Lookups.2260hub # [ 23.045416] systemd[1]: Reached target User and Group Name Lookups.2261hub # [ 23.047763] nsncd[1146]: Oct 06 15:05:51.073 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2262hub # [ 23.053803] tailscaled[703]: health(warnable=warming-up): ok2263hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ey9lVlBhVvzM-aJp9aSB6Xwzt4eNl4G3gfbej9-2s44irmG4wetheDHzZX902STMiGleLZXHnZhlz --hostname hub, in 2.47 seconds)2264worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ey9lVlBhVvzM-aJp9aSB6Xwzt4eNl4G3gfbej9-2s44irmG4wetheDHzZX902STMiGleLZXHnZhlz --hostname tt-worker2265worker # [ 14.014373] tailscaled[629]: localapi: [POST] /localapi/v0/check-prefs2266worker # [ 14.016676] tailscaled[629]: localapi: [POST] /localapi/v0/start2267worker # [ 14.018998] tailscaled[629]: control: client.Shutdown ...2268worker # [ 14.020431] tailscaled[629]: control: mapRoutine: exiting2269worker # [ 14.021786] tailscaled[629]: control: authRoutine: exiting2270worker # [ 14.023291] tailscaled[629]: control: updateRoutine: exiting2271worker # [ 14.024580] tailscaled[629]: control: Client.Shutdown done.2272worker # [ 14.026293] tailscaled[629]: Start2273worker # [ 14.027427] tailscaled[629]: 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]2274worker # [ 14.030723] tailscaled[629]: generating new machine key2275worker # [ 14.041095] tailscaled[629]: machine key written to store2276worker # [ 14.042484] tailscaled[629]: profile data directory: profile not found2277worker # [ 14.044532] tailscaled[629]: Backend: logs: be:6cfbf59580034429071193f1ab50ea2a76593d0daf6fa1cf296fbb0eab881234 fe:2278worker # [ 14.049677] tailscaled[629]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false)2279worker # [ 14.051761] tailscaled[629]: blockEngineUpdates(true)2280worker # [ 14.053353] tailscaled[629]: Reconfig(down): no changes made to Engine config2281worker # [ 14.056175] tailscaled[629]: health(warnable=warming-up): error: Tailscale is starting. Please wait.2282worker # [ 14.057867] tailscaled[629]: health(warnable=wantrunning-false): ok2283worker # [ 14.060723] tailscaled[629]: localapi: [POST] /localapi/v0/login-interactive2284worker # [ 14.062169] tailscaled[629]: StartLoginInteractiveAs("root"): url=false2285worker # [ 14.063464] tailscaled[629]: control: client.Login(2)2286worker # [ 14.067715] tailscaled[629]: control: LoginInteractive -> regen=true2287worker # [ 14.069048] tailscaled[629]: control: doLogin(regen=true, hasUrl=false)2288worker # [ 14.105107] tailscaled[629]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2289hub # [ 23.188153] headscale-start[992]: 2026-10-06T15:05:51Z INF http request bytes=176 elapsed=0.40927 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:39408 status=2002290worker # [ 14.116089] tailscaled[629]: control: control server key from https://hub: ts2021=[cfmur], legacy=2291worker # [ 14.117838] tailscaled[629]: control: Generating a new nodekey.2292worker # [ 14.119492] tailscaled[629]: control: RegisterReq: onode= node=[b3eqv] fup=false nks=false2293hub # [ 23.458446] headscale-start[992]: 2026-10-06T15:05:51Z INF http request bytes=0 elapsed=412.933208 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35688 status=2002294hub # [ 23.958424] headscale-start[992]: 2026-10-06T15:05:51Z INF http request bytes=0 elapsed=494.482679 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:35688 status=2002295hub # [ 23.961962] headscale-start[992]: 2026-10-06T15:05:51Z INF http request bytes=249 elapsed=756.615156 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:39420 status=2002296worker # [ 14.889440] tailscaled[629]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false2297worker # [ 14.892803] tailscaled[629]: blockEngineUpdates(false)2298hub # [ 24.459451] headscale-start[992]: 2026-10-06T15:05:52Z INF http request bytes=0 elapsed=488.701776 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:39420 status=2002299worker # [ 15.528210] dhcpcd[697]: eth0: leased 10.0.2.15 for 86400 seconds2300worker # [ 15.529868] dhcpcd[697]: eth0: adding route to 10.0.2.0/242301worker # [ 15.532919] dhcpcd[697]: eth0: adding default route via 10.0.2.22302worker # [ 15.534178] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=2552303worker # [ 15.537081] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=2552304worker # [ 15.540687] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=2542305worker # [ 15.544311] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=2542306worker # [ 15.548522] tailscaled[629]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::bd1a:c289:7db8:9808/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::bd1a:c289:7db8:9808/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::bd1a:c289:7db8:9808/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::bd1a:c289:7db8:9808/64] rebind-reason=[ips-changed]2307worker # [ 15.558945] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}2308worker # [ 15.563272] tailscaled[629]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}2309worker # [ 15.564928] tailscaled[629]: dns: OScfg: {}2310worker # [ 15.618470] systemd[1]: Started DHCP Client.2311worker # [ 15.621103] systemd[1]: Reached target Multi-User System.2312worker # [ 15.622392] systemd[1]: Startup finished in 1.277s (kernel) + 4.022s (initrd) + 10.320s (userspace) = 15.620s.2313hub # [ 24.746226] tailscaled[703]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2314hub # [ 24.753413] tailscaled[703]: wgengine: Reconfig: configuring router2315hub # [ 24.755685] tailscaled[703]: wgengine: Reconfig: user dialer2316hub # [ 24.757075] tailscaled[703]: tsdial: bart table size: 42317hub # [ 24.758407] tailscaled[703]: wgengine: Reconfig: configuring DNS2318hub # [ 24.759763] tailscaled[703]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2319hub # [ 24.790565] tailscaled[703]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2320hub # [ 24.792303] tailscaled[703]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2321hub # [ 24.960047] headscale-start[992]: 2026-10-06T15:05:52Z INF node connected machine.key=[3j2XJ] node.expired=false node.id=2 node.is_tagged=false node.key=[b3eqv] node.name=tt-worker node.online=true user.name=test2322hub # [ 24.963078] headscale-start[992]: 2026-10-06T15:05:52Z INF github.com/juanfont/headscale/hscontrol/poll.go:250 > node has connected chan=0x637e0b75c70 component=poll machine.key=[3j2XJ] node.expired=false node.id=2 node.is_tagged=false node.key=[b3eqv] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test2323worker # [ 15.901472] tailscaled[629]: magicsock: new contact: control-netmap usec=5706255 cached=false2324worker # [ 15.904292] tailscaled[629]: active login: test2325worker # [ 15.907789] tailscaled[629]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.152326worker # [ 15.912935] tailscaled[629]: netmap: suggested exit node: no preferred DERP, try again later2327worker # [ 15.916180] tailscaled[629]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true)2328worker # [ 15.918231] tailscaled[629]: magicsock: SetPrivateKey called (init)2329worker # [ 15.919555] tailscaled[629]: wgengine: Reconfig: configuring router2330worker # [ 16.037496] tailscaled[629]: router: enabling connmark-based rp_filter workaround2331worker # [ 16.053513] tailscaled[629]: wgengine: Reconfig: user dialer2332worker # [ 16.054863] tailscaled[629]: tsdial: bart table size: 42333worker # [ 16.055993] tailscaled[629]: wgengine: Reconfig: configuring DNS2334worker # [ 16.173246] tailscaled[629]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [11ms] (forced=false)2335worker # [ 16.175947] tailscaled[629]: magicsock: home is now derp-999 ()2336worker # [ 16.177747] tailscaled[629]: 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::bd1a:c289:7db8:9808]:41641 (local)2337worker # [ 16.181911] tailscaled[629]: magicsock: adding connection to derp-999 for home-keep-alive2338worker # [ 16.183447] tailscaled[629]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2339worker # [ 16.184730] tailscaled[629]: derphttp.Client.Connect: connecting to derp-999 ()2340worker # [ 16.189318] tailscaled[629]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2341worker # [ 16.196717] tailscaled[629]: magicsock: derp-999 connected; connGen=12342worker # [ 16.589389] tailscaled[629]: wgengine: set DNS config again after major link change2343worker # [ 16.591295] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2344worker # [ 16.594074] tailscaled[629]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::bd1a:c289:7db8:9808/64]2345worker # [ 16.597285] tailscaled[629]: magicsock: closing connection to derp-999 (rebind-default-route-change), age 0s2346worker # [ 16.599109] tailscaled[629]: magicsock: 0 active derp conns2347worker # [ 16.600263] tailscaled[629]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::bd1a:c289:7db8:9808/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::bd1a:c289:7db8:9808/64] eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6] tailscale0:[100.64.0.2/32 fd7a:115c:a1e0::2/128 llu6]} v4=true v6=true} diff: ips tailscale0: [fe80::f016:c123:7ee:b3c8/64]->[100.64.0.2/32 fd7a:115c:a1e0::2/128 fe80::f016:c123:7ee:b3c8/64] rebind-reason=[ips-changed]2348hub # [ 25.691303] headscale-start[992]: 2026-10-06T15:05:53Z INF http request bytes=0 elapsed=420.952943 method=GET path=/derp proto=HTTP/1.1 remote=127.0.0.1:39422 status=02349worker # [ 16.616121] tailscaled[629]: router: portUpdate(port=41641, network=udp6)2350worker # [ 16.617898] tailscaled[629]: router: portUpdate(port=41641, network=udp4)2351worker # [ 16.619366] tailscaled[629]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)")2352worker # [ 16.620965] tailscaled[629]: magicsock: adding connection to derp-999 for home-keep-alive2353worker # [ 16.622820] tailscaled[629]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s2354worker # [ 16.624214] tailscaled[629]: derphttp.Client.Recv: connecting to derp-999 ()2355worker # [ 16.631722] tailscaled[629]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2356worker # [ 16.637670] tailscaled[629]: magicsock: derp-999 connected; connGen=12357worker # [ 16.648086] tailscaled[629]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2358worker # [ 16.650195] tailscaled[629]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2359worker # [ 16.688990] systemd[1]: Stopped target Host and Network Name Lookups.2360worker # [ 16.691835] systemd[1]: Stopping Host and Network Name Lookups...2361worker # [ 16.695631] systemd[1]: Stopped target User and Group Name Lookups.2362worker # [ 16.699720] systemd[1]: Stopping User and Group Name Lookups...2363worker # [ 16.701303] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2364worker # [ 16.704724] systemd[1]: nscd.service: Deactivated successfully.2365worker # [ 16.706790] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2366worker # [ 16.714106] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2367worker # [ 16.721846] tailscaled[629]: peerapi: serving on http://100.64.0.2:465902368worker # [ 16.725407] tailscaled[629]: peerapi: serving on http://[fd7a:115c:a1e0::2]:471662369worker # [ 16.728732] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0}2370worker # [ 16.735496] tailscaled[629]: Switching ipn state Starting -> Running (WantRunning=true, nm=true)2371worker # [ 16.739823] tailscaled[629]: updating netmap in disk cache2372worker # [ 16.744082] tailscaled[629]: health(warnable=warming-up): ok2373worker # [ 16.745156] tailscaled[629]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2374worker # [ 16.749244] systemd[1]: Started Name Service Cache Daemon (nsncd).2375worker # [ 16.751215] nsncd[991]: Oct 06 15:05:53.895 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2376worker # [ 16.754791] systemd[1]: Reached target Host and Network Name Lookups.2377worker # [ 16.756265] systemd[1]: Reached target User and Group Name Lookups.2378worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-ey9lVlBhVvzM-aJp9aSB6Xwzt4eNl4G3gfbej9-2s44irmG4wetheDHzZX902STMiGleLZXHnZhlz --hostname tt-worker, in 2.78 seconds)2379??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.2380 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 392381worker: waiting for success: tailscale ping hub2382??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.2383 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 392384worker # [ 16.778436] tailscaled[629]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa}2385worker # [ 16.781412] tailscaled[629]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] }2386worker # [ 16.806804] tailscaled[629]: localapi: [POST] /localapi/v0/ping2387worker # [ 16.810082] tailscaled[629]: ping(100.64.0.1): sending disco ping to [tMjhf] hub ...2388worker # [ 16.812216] tailscaled[629]: magicsock: disco: node [tMjhf] d:ec8b4b0a07325195 now using [2001:db8:1::1]:41641 mtu=1360 tx=c0ed7a6b55a92389worker # [ 16.814635] tailscaled[629]: magicsock: new contact: peer=[tMjhf] usec=6619950 cached=false via=direct2390worker: (finished: waiting for success: tailscale ping hub, in 0.05 seconds)2391hub: must succeed: tailscale ip -42392worker # [ 16.820532] tailscaled[629]: wgengine: set DNS config again after major link change2393worker # [ 16.823351] tailscaled[629]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::bd1a:c289:7db8:9808/64]2394worker # [ 16.827091] tailscaled[629]: magicsock: closing connection to derp-999 (rebind-default-route-change), age 0s2395worker # [ 16.829067] tailscaled[629]: magicsock: 0 active derp conns2396hub # [ 25.905222] headscale-start[992]: 2026-10-06T15:05:53Z INF http request bytes=0 elapsed=195.09379 method=GET path=/derp proto=HTTP/1.1 remote=127.0.0.1:39426 status=02397worker # [ 16.830299] tailscaled[629]: [RATELIMIT] format("magicsock: %v active derp conns%s")2398worker # [ 16.831830] tailscaled[629]: magicsock: adding connection to derp-999 for home-keep-alive2399worker # [ 16.834077] tailscaled[629]: derphttp.Client.Recv: connecting to derp-999 ()2400worker # [ 16.839139] tailscaled[629]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub"2401worker # [ 16.843321] tailscaled[629]: magicsock: derp-999 connected; connGen=12402hub: (finished: must succeed: tailscale ip -4, in 0.04 seconds)2403worker: 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.toml2404worker: (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.01 seconds)2405hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub2406hub # [ 25.961324] headscale-start[992]: 2026-10-06T15:05:53Z INF http request bytes=0 elapsed=150.299549 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:39420 status=2002407hub # [ 25.993137] systemd[1]: Starting tribuchet-hub.socket...2408hub # [ 26.001112] systemd[1]: Listening on tribuchet-hub.socket.2409hub # [ 26.005990] systemd[1]: Starting tribuchet-hub.service...2410hub # [ 26.056694] tribuchet[1189]: 2026-10-06T15:05:54.085734Z INFO tribuchet::hub::serve: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[]2411hub # [ 26.062441] tribuchet[1189]: 2026-10-06T15:05:54.092295Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true2412hub # [ 26.069112] tribuchet[1189]: 2026-10-06T15:05:54.098852Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock2413hub # [ 26.073859] systemd[1]: Started tribuchet-hub.service.2414hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.13 seconds)2415worker: must succeed: systemctl start tribuchet-worker2416worker # [ 17.019653] systemd[1]: Starting tribuchet build worker...2417worker # [ 17.045266] tribuchet[1036]: 2026-10-06T15:05:54.192902Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None }2418worker # [ 17.058357] tribuchet[1036]: 2026-10-06T15:05:54.205688Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox")2419worker # [ 17.065525] systemd[1]: Started tribuchet build worker.2420worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.07 seconds)2421hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"'2422worker # [ 17.071771] systemd[1]: Starting tribuchet build agent 1...2423worker # [ 17.108873] systemd[1]: Started tribuchet build agent 1.2424worker # [ 17.131975] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1044]: 2026-10-06T15:05:54.279745Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362425worker # [ 17.135979] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1044]: 2026-10-06T15:05:54.283973Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2426worker # [ 17.139725] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1044]: 2026-10-06T15:05:54.287119Z INFO tribuchet::worker::agent: agent listening uid=655042427worker # [ 17.144406] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1044]: 2026-10-06T15:05:54.287229Z INFO tribuchet::worker::agent: no build held, exiting until the next activation2428worker # [ 17.149076] systemd[1]: tribuchet-agent@1.service: Deactivated successfully.2429worker # [ 17.152511] tailscaled[629]: magicsock: disco: node [tMjhf] d:ec8b4b0a07325195 now using [2001:db8:1::1]:41641 mtu=1360 tx=9f870ecc4bce2430worker # [ 17.155113] tailscaled[629]: magicsock: new contact: peer=[tMjhf] usec=6959964 cached=false via=direct2431hub # [ 26.234567] tailscaled[703]: wg: [b3eqv] - Failed to send handshake response: no UDP or DERP addr2432hub # [ 26.237207] tailscaled[703]: magicsock: new contact: peer=[b3eqv] usec=11934904 cached=false via=derp2433hub # [ 26.241099] tailscaled[703]: magicsock: disco: node [b3eqv] d:81e7f2652ac5aefc now using [2001:db8:1::2]:41641 mtu=1360 tx=e411217380052434hub # [ 26.243965] tailscaled[703]: magicsock: new contact: peer=[b3eqv] usec=11941434 cached=false via=direct2435hub # [ 26.246596] tailscaled[703]: magicsock: disco: node [b3eqv] d:81e7f2652ac5aefc now using 192.168.1.2:41641 mtu=1360 tx=ee40d6d49f032436worker # [ 17.265223] tailscaled[629]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"}2437hub # [ 26.462472] headscale-start[992]: 2026-10-06T15:05:54Z INF http request bytes=0 elapsed=493.698781 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:39420 status=2002438hub # [ 26.964357] headscale-start[992]: 2026-10-06T15:05:54Z INF http request bytes=0 elapsed=495.769713 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:39420 status=2002439worker # [ 18.068124] tailscaled[629]: [RATELIMIT] format("control: [v\x00JSON]%d%s")2440worker # [ 22.146209] tailscaled[629]: open-conn-track: timeout opening (TCP 100.64.0.2:44488 => 100.64.0.1:7437) to node [tMjhf]; online=yes, lastRecv=never2441hub # [ 31.291397] tribuchet[1189]: 2026-10-06T15:05:59.320873Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }]2442hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 5.18 seconds)2443subtest: a build dispatches over the tailnet2444hub: must succeed: echo tailscale-auth-payload > /root/payload2445worker # [ 22.250662] tribuchet[1036]: 2026-10-06T15:05:59.397124Z INFO tribuchet::worker::session: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"]2446hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.01 seconds)2447hub: must succeed: nix-store --add /root/payload2448hub: (finished: must succeed: nix-store --add /root/payload, in 0.10 seconds)2449hub: must succeed: cat > /root/test.nix << 'EOF'2450let2451 bash = builtins.storePath "/nix/store/7a60q5dgnv6z96c279rc1nalyiw4mgqn-bash-interactive-5.3p15";2452 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2453in derivation {2454 name = "tt-tailscale";2455 system = "x86_64-linux";2456 builder = bash + "/bin/bash";2457 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2458}2459EOF2460hub: (finished: must succeed: cat > /root/test.nix << 'EOF'2461let2462 bash = builtins.storePath "/nix/store/7a60q5dgnv6z96c279rc1nalyiw4mgqn-bash-interactive-5.3p15";2463 unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload";2464in derivation {2465 name = "tt-tailscale";2466 system = "x86_64-linux";2467 builder = bash + "/bin/bash";2468 args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ];2469}2470EOF, in 0.02 seconds)2471hub: must succeed: nix-build /root/test.nix --no-out-link2472hub # this derivation will be built:2473hub # /nix/store/cvz23131m26jpbalbxk88f5sds5xnfkc-tt-tailscale.drv2474hub # building '/nix/store/cvz23131m26jpbalbxk88f5sds5xnfkc-tt-tailscale.drv'...2475hub # [ 31.721850] tribuchet[1189]: 2026-10-06T15:05:59.751860Z INFO tribuchet::hub::submit: queueing build id="16359561ce6032dcef0eca28f27ce5df" system="x86_64-linux"2476hub # [ 31.727514] tribuchet[1189]: 2026-10-06T15:05:59.757525Z INFO tribuchet::hub: dispatching build id="16359561ce6032dcef0eca28f27ce5df" worker="tt-worker"2477hub # tribuchet: building on tt-worker2478worker # [ 22.660089] tribuchet[1036]: 2026-10-06T15:05:59.806014Z INFO tribuchet::worker::session: build assigned id="16359561ce6032dcef0eca28f27ce5df"2479worker # [ 22.669702] systemd[1]: Started Nix Daemon.2480worker # [ 22.740142] nix-daemon[1049]: accepted connection from pid 1036, user tribuchet (trusted)2481hub # [ 31.826839] tribuchet[1189]: 2026-10-06T15:05:59.856768Z INFO tribuchet::hub::relay::staging: input path negotiation done id="16359561ce6032dcef0eca28f27ce5df" total=8 missing=12482hub # [ 31.835493] systemd[1]: Started Nix Daemon.2483hub # [ 31.908449] nix-daemon[1253]: accepted connection from pid 1189, user root (trusted)2484worker # [ 22.859770] nix-daemon[1049]: accepted connection from pid 1036, user tribuchet (trusted)2485worker # [ 22.867839] tribuchet[1036]: 2026-10-06T15:06:00.015798Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="16359561ce6032dcef0eca28f27ce5df" fixed_output=false network=false net_isolation=false2486worker # [ 22.878724] systemd[1]: Starting tribuchet build agent 1...2487worker # [ 22.939662] systemd[1]: Started tribuchet build agent 1.2488worker # [ 22.986394] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1061]: 2026-10-06T15:06:00.133657Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362489worker # [ 22.993247] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1061]: 2026-10-06T15:06:00.134184Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2490worker # [ 22.998164] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1061]: 2026-10-06T15:06:00.134235Z INFO tribuchet::worker::agent: agent listening uid=655042491worker # [ 23.015468] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1061]: 2026-10-06T15:06:00.163404Z INFO tribuchet::worker::agent: builder started id="16359561ce6032dcef0eca28f27ce5df" pid=10672492worker # [ 23.022447] tribuchet[1036]: 2026-10-06T15:06:00.170162Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="16359561ce6032dcef0eca28f27ce5df" pid=1067 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/97aa706f4d232d38/build2493worker # [ 23.040922] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1061]: 2026-10-06T15:06:00.188869Z INFO tribuchet::worker::agent: builder exited code=02494worker # [ 23.222844] tribuchet[1036]: 2026-10-06T15:06:00.370630Z INFO tribuchet::worker::build::agent_exec: builder finished id="16359561ce6032dcef0eca28f27ce5df" exit_code=0 aborted=None2495worker # [ 23.236069] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1061]: 2026-10-06T15:06:00.383727Z INFO tribuchet::worker::agent: cleanup done id="16359561ce6032dcef0eca28f27ce5df"2496worker # [ 23.241409] systemd[1]: tribuchet-agent@1.service: Deactivated successfully.2497worker # [ 23.249220] systemd[1]: Starting tribuchet build agent 1...2498worker # [ 23.283906] systemd[1]: Started tribuchet build agent 1.2499worker # [ 23.304343] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1082]: 2026-10-06T15:06:00.452108Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362500worker # [ 23.308861] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1082]: 2026-10-06T15:06:00.456829Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2501worker # [ 23.312424] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1082]: 2026-10-06T15:06:00.460373Z INFO tribuchet::worker::agent: agent listening uid=655042502worker # [ 23.315788] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1082]: 2026-10-06T15:06:00.463366Z INFO tribuchet::worker::agent: no build held, exiting until the next activation2503worker # [ 23.320257] systemd[1]: tribuchet-agent@1.service: Deactivated successfully.2504worker # [ 23.330981] tribuchet[1036]: 2026-10-06T15:06:00.477294Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="16359561ce6032dcef0eca28f27ce5df"2505worker # [ 23.342565] tribuchet[1036]: 2026-10-06T15:06:00.490511Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="16359561ce6032dcef0eca28f27ce5df"2506hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 0.98 seconds)2507hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/667vxncdcca78rn0fyqbrb7rvn7aiyis-tt-tailscale2508hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/667vxncdcca78rn0fyqbrb7rvn7aiyis-tt-tailscale, in 0.02 seconds)2509hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build'2510hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.02 seconds)2511worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished'2512worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.01 seconds)2513(finished: subtest: a build dispatches over the tailnet, in 1.16 seconds)2514subtest: a non-tailnet peer is rejected2515worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml2516worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.01 seconds)2517worker: must succeed: systemctl restart tribuchet-worker2518worker # [ 23.430856] tribuchet[1036]: 2026-10-06T15:06:00.578780Z INFO tribuchet::worker: handover requested; exiting2519worker # [ 23.434182] systemd[1]: Stopping tribuchet build worker...2520worker # [ 23.437341] systemd[1]: tribuchet-worker.service: Deactivated successfully.2521worker # [ 23.440230] systemd[1]: Stopped tribuchet build worker.2522hub # [ 32.516153] tribuchet[1189]: 2026-10-06T15:06:00.545584Z INFO tribuchet::hub: worker disconnected worker="tt-worker"2523worker # [ 23.441858] systemd[1]: tribuchet-worker.service: Consumed 29ms CPU time over 6.420s wall clock time, 2.2M memory peak, 4K written to disk, 3.3K incoming IP traffic, 2.4K outgoing IP traffic.2524worker # [ 23.448559] systemd[1]: Starting tribuchet build worker...2525worker # [ 23.470680] tribuchet[1099]: 2026-10-06T15:06:00.617740Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None }2526worker # [ 23.481684] tribuchet[1099]: 2026-10-06T15:06:00.618433Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox")2527worker # [ 23.489411] systemd[1]: Started tribuchet build worker.2528worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.08 seconds)2529hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed'2530worker # [ 23.497753] systemd[1]: Starting tribuchet build agent 1...2531worker # [ 23.534229] systemd[1]: Started tribuchet build agent 1.2532worker # [ 23.561224] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1107]: 2026-10-06T15:06:00.708920Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=655362533worker # [ 23.566300] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1107]: 2026-10-06T15:06:00.713156Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true2534worker # [ 23.569589] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1107]: 2026-10-06T15:06:00.713189Z INFO tribuchet::worker::agent: agent listening uid=655042535worker # [ 23.575434] 55yya49kx58gllmp330n5f3srslngy5p-tribuchet-agent[1107]: 2026-10-06T15:06:00.713300Z INFO tribuchet::worker::agent: no build held, exiting until the next activation2536worker # [ 23.580796] systemd[1]: tribuchet-agent@1.service: Deactivated successfully.2537hub # [ 33.067924] tribuchet[1189]: 2026-10-06T15:06:01.097268Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:378362538worker # [ 24.005196] tribuchet[1099]: 2026-10-06T15:06:01.150874Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet"2539worker # [ 24.012695] tribuchet[1099]: 2026-10-06T15:06:01.160625Z INFO tribuchet::worker: reconnecting to hub in 1s2540hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.25 seconds)2541(finished: subtest: a non-tailnet peer is rejected, in 1.33 seconds)2542(finished: run the VM test script, in 35.08 seconds)2543test script finished in 35.13s2544cleanup2545kill QemuMachine (pid 48)2546hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2547kill QemuMachine (pid 47)2548worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2549(finished: cleanup, in 0.46 seconds)