tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script start all VMs hub: starting vm worker: starting vm hub # Disk image does not exist, creating the virtualisation disk image... hub: QEMU running (pid 47) hub # Formatting '/build/vm-state-hub/tmp.h7OLCUUw7r', fmt=raw size=1073741824 hub # mke2fs 1.47.4 (6-Mar-2025) hub # Discarding device blocks: 0/262144 done hub # Creating filesystem with 262144 4k blocks and 65536 inodes hub # Filesystem UUID: 5ac5da24-cb79-46c3-82b1-0a21b4f663ac hub # Superblock backups stored on blocks: hub # 32768, 98304, 163840, 229376 hub # hub # Allocating group tables: 0/8 done hub # Writing inode tables: 0/8 done hub # Creating journal (8192 blocks): done hub # Writing superblocks and filesystem accounting information: 0/8 done hub # hub # Virtualisation disk image created. hub # Starting virtiofs daemons... hub # [2026-10-25T16:57:25Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-10-25T16:57:25Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-10-25T16:57:25Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-10-25T16:57:25Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-10-25T16:57:25Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-10-25T16:57:25Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-10-25T16:57:25Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) hub # [2026-10-25T16:57:25Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether hub # [2026-10-25T16:57:25Z INFO virtiofsd] Waiting for vhost-user socket connection... hub # [2026-10-25T16:57:25Z INFO virtiofsd] Client connected, servicing requests hub # [2026-10-25T16:57:25Z INFO virtiofsd] Client connected, servicing requests hub # [2026-10-25T16:57:25Z INFO virtiofsd] Client connected, servicing requests hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC730+7EF2C730 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 7EFCC730 7EF2C730 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:05.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026 hub # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/mnbg0png64a8cr8c2s47gqqdpw0kypwv-nixos-system-hub-test/init regInfo=/nix/.ro-store/qb7bzlmrhg4sv6qgm9b2gf3m5ij68kjv-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.000000] BIOS-provided physical RAM map: hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved hub # [ 0.000000] NX (Execute Disable) protection: active hub # [ 0.000000] APIC: Static calls initialized hub # [ 0.000000] SMBIOS 2.8 present. hub # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 hub # [ 0.000000] DMI: Memory slots populated: 1/1 hub # [ 0.000000] Hypervisor detected: KVM hub # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000001] kvm-clock: using sched offset of 613337214 cycles hub # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000005] tsc: Detected 2400.008 MHz processor hub # [ 0.000766] last_pfn = 0x7ffd8 max_arch_pfn = 0x10000000000 hub # [ 0.000793] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000795] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002684] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.002696] Using GB pages for direct mapping hub # [ 0.002757] RAMDISK: [mem 0x7e2e6000-0x7ffcffff] hub # [ 0.002766] ACPI: Early table checksum verification disabled hub # [ 0.002769] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) hub # [ 0.002773] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002777] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002785] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002787] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.002789] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002791] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002792] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002794] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.002795] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d] hub # [ 0.002796] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219] hub # [ 0.002797] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.002797] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385] hub # [ 0.002798] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd] hub # [ 0.002798] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9] hub # [ 0.002799] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421] hub # [ 0.003028] No NUMA configuration found hub # [ 0.003029] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] hub # [ 0.003031] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] hub # [ 0.005376] Zone ranges: hub # [ 0.005377] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.005379] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] hub # [ 0.005380] Normal empty hub # [ 0.005381] Device empty hub # [ 0.005382] Movable zone start for each node hub # [ 0.005382] Early memory node ranges hub # [ 0.005383] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.005384] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.005385] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] hub # [ 0.005406] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.005692] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.043063] On node 0, zone DMA32: 40 pages in unavailable ranges hub # [ 0.043538] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.043553] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.043592] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.043595] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.043597] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.043598] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.043599] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.043600] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.043602] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.043604] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.043608] TSC deadline timer available hub # [ 0.043623] CPU topo: Max. logical packages: 1 hub # [ 0.043624] CPU topo: Max. logical dies: 1 hub # [ 0.043624] CPU topo: Max. dies per package: 1 hub # [ 0.043628] CPU topo: Max. threads per core: 1 hub # [ 0.043628] CPU topo: Num. cores per package: 1 hub # [ 0.043629] CPU topo: Num. threads per package: 1 hub # [ 0.043629] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.043656] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.043693] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.043695] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.043696] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.043698] Booting paravirtualized kernel on KVM hub # [ 0.043702] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.048357] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.050934] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.050989] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.050991] 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/mnbg0png64a8cr8c2s47gqqdpw0kypwv-nixos-system-hub-test/init regInfo=/nix/.ro-store/qb7bzlmrhg4sv6qgm9b2gf3m5ij68kjv-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.051092] Unknown kernel command line parameters "regInfo=/nix/.ro-store/qb7bzlmrhg4sv6qgm9b2gf3m5ij68kjv-closure-info/registration", will be passed to user space. hub # [ 0.051105] random: crng init done hub # [ 0.051106] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.053353] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.053382] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.053421] Fallback order for Node 0: 0 hub # [ 0.053424] Built 1 zonelists, mobility grouping on. Total pages: 524150 hub # [ 0.053425] Policy zone: DMA32 hub # [ 0.056013] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.060341] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.064979] allocated 4194304 bytes of page_ext hub # [ 0.075448] ftrace: allocating 48837 entries in 192 pages hub # [ 0.075450] ftrace: allocated 192 pages with 2 groups hub # [ 0.076320] Dynamic Preempt: lazy hub # [ 0.076484] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.076485] rcu: RCU event tracing is enabled. hub # [ 0.076486] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.076487] Trampoline variant of Tasks RCU enabled. hub # [ 0.076488] Rude variant of Tasks RCU enabled. hub # [ 0.076488] Tracing variant of Tasks RCU enabled. hub # [ 0.076489] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.076490] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.076511] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.076513] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.076514] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.080842] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.081134] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.081144] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.081257] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.084785] Console: colour VGA+ 80x25 hub # [ 0.084788] printk: legacy console [tty0] enabled hub # [ 0.114311] printk: legacy console [ttyS0] enabled hub # [ 0.220689] ACPI: Core revision 20250807 hub # [ 0.221599] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.223223] APIC: Switch to symmetric I/O mode setup hub # [ 0.224268] x2apic enabled hub # [ 0.225018] APIC: Switched APIC routing to: physical x2apic hub # [ 0.226933] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.227983] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns hub # [ 0.229751] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) hub # [ 0.231788] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.232879] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.233748] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.234751] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.235747] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.236748] Transient Scheduler Attacks: Vulnerable: No microcode hub # [ 0.237747] Spectre V2 : Mitigation: Enhanced / Automatic IBRS hub # [ 0.238747] Speculative Return Stack Overflow: Mitigation: Safe RET hub # [ 0.239747] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.241755] Spectre V2 : Enabling IBPB for BPF hub # [ 0.242748] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.243748] active return thunk: srso_alias_return_thunk hub # [ 0.244667] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.245747] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.246747] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.247747] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' hub # [ 0.248747] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' hub # [ 0.249747] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' hub # [ 0.250747] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' hub # [ 0.251748] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.253747] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 hub # [ 0.254747] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 hub # [ 0.255748] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 hub # [ 0.256747] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 hub # [ 0.257747] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. hub # [ 0.292727] Freeing SMP alternatives memory: 48K hub # [ 0.293348] pid_max: default: 32768 minimum: 301 hub # [ 0.294429] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.294848] landlock: Up and running. hub # [ 0.296228] Yama: becoming mindful. hub # [ 0.296972] LSM support for eBPF active hub # [ 0.297867] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.298784] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.301652] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) hub # [ 0.302259] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.302752] ... version: 2 hub # [ 0.303497] ... bit width: 48 hub # [ 0.303750] ... generic counters: 6 hub # [ 0.304502] ... generic bitmap: 000000000000003f hub # [ 0.304795] ... fixed-purpose counters: 0 hub # [ 0.305554] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.306497] ... value mask: 0000ffffffffffff hub # [ 0.306750] ... max period: 00007fffffffffff hub # [ 0.307681] ... global_ctrl mask: 000000000000003f hub # [ 0.308584] signal: max sigframe size: 3376 hub # [ 0.309393] rcu: Hierarchical SRCU implementation. hub # [ 0.309753] rcu: Max phase no-delay instances is 400. hub # [ 0.315291] smp: Bringing up secondary CPUs ... hub # [ 0.315764] smp: Brought up 1 node, 1 CPU hub # [ 0.316445] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) hub # [ 0.316937] Memory: 1969136K/2096600K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 118052K reserved, 0K cma-reserved) hub # [ 0.318083] devtmpfs: initialized hub # [ 0.318904] x86/mm: Memory block size: 128MB hub # [ 0.320776] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.321778] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.322829] pinctrl core: initialized pinctrl subsystem hub # [ 0.324029] PM: RTC time: 16:57:25, date: 2026-10-25 hub # [ 0.327832] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.329252] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.329772] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.331031] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.331759] audit: initializing netlink subsys (disabled) hub # [ 0.332752] audit: type=2000 audit(1792947445.871:1): state=initialized audit_enabled=0 res=1 hub # [ 0.333953] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.333955] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.334751] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.335741] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.336518] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.336764] cpuidle: using governor menu hub # [ 0.339016] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.339978] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.340752] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.341761] PCI: Using configuration type 1 for base access hub # [ 0.342920] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.348014] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.348750] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.353751] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.354749] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.365153] ACPI: Added _OSI(Module Device) hub # [ 0.365751] ACPI: Added _OSI(Processor Device) hub # [ 0.366504] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.375046] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.379153] ACPI: Interpreter enabled hub # [ 0.379765] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.380483] ACPI: Using IOAPIC for interrupt routing hub # [ 0.382809] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.383750] PCI: Using E820 reservations for host bridge windows hub # [ 0.386887] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.392698] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.393579] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.394828] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.395873] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.397094] PCI host bridge to bus 0000:00 hub # [ 0.397754] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.398750] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.399750] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.400750] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.401750] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.402750] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] hub # [ 0.403751] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.404775] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.406227] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.408947] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.409763] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.411122] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.412096] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.413484] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.415781] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] hub # [ 0.416672] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.417569] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.418757] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.420344] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.421787] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] hub # [ 0.422654] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.423517] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.425245] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.427514] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.428468] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.428771] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.430359] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.432988] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.434451] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.434772] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.435757] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.437294] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.438763] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.439773] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.441350] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.444586] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.445551] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.447258] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.449303] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.449772] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.451362] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint hub # [ 0.452807] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.453774] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.455336] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.457703] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.458410] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.458773] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.460338] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.462786] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.463758] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.464772] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.466379] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.467448] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] hub # [ 0.467964] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.469428] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] hub # [ 0.469945] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.471459] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] hub # [ 0.472013] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.474489] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.475012] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.476049] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.477047] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.478801] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] hub # [ 0.479690] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.480844] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.482504] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.486323] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.486868] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.487852] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.488847] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.489855] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.490846] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.491849] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.492850] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.493794] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.494765] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.495762] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.496765] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.497766] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.498762] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.499762] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.500767] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.502826] iommu: Default domain type: Translated hub # [ 0.503655] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.504833] ACPI: bus type USB registered hub # [ 0.505647] usbcore: registered new interface driver usbfs hub # [ 0.506522] usbcore: registered new interface driver hub hub # [ 0.506760] usbcore: registered new device driver usb hub # [ 0.508563] NetLabel: Initializing hub # [ 0.508756] NetLabel: domain hash size = 128 hub # [ 0.509518] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.509780] NetLabel: unlabeled traffic allowed by default hub # [ 0.510761] PCI: Using ACPI for IRQ routing hub # [ 0.554746] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 0.554746] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 0.554746] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.554755] vgaarb: loaded hub # [ 0.555485] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.555750] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.560837] clocksource: Switched to clocksource kvm-clock hub # [ 0.562583] VFS: Disk quotas dquot_6.6.0 hub # [ 0.565240] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.566711] pnp: PnP ACPI init hub # [ 0.567506] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 0.568508] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 0.570101] pnp: PnP ACPI: found 5 devices hub # [ 0.577683] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.579165] clocksource: Switched to clocksource acpi_pm hub # [ 0.580185] NET: Registered PF_INET protocol family hub # [ 0.581448] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.598413] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.599930] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.601198] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.602499] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.603717] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.604781] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.606033] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.607089] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.608275] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.609227] NET: Registered PF_XDP protocol family hub # [ 0.610055] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.611034] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.612152] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.613229] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 0.614290] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 0.615350] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] hub # [ 0.617023] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 0.619147] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 0.621170] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 0.623152] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 0.624863] PCI: CLS 0 bytes, default 64 hub # [ 0.625724] Trying to unpack rootfs image as initramfs... hub # [ 0.630070] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns hub # [ 0.671976] Initialise system trusted keyrings hub # [ 0.674789] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.694427] Key type asymmetric registered hub # [ 0.697663] Asymmetric key parser 'x509' registered hub # [ 0.698464] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.701744] io scheduler mq-deadline registered hub # [ 0.702476] io scheduler kyber registered hub # [ 0.705243] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.706483] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.712024] Linux agpgart interface v0.103 hub # [ 0.712766] ACPI: bus type drm_connector registered hub # [ 0.715987] usbcore: registered new interface driver usbserial_generic hub # [ 0.717028] usbserial: USB Serial support registered for generic hub # [ 0.720632] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. hub # [ 0.720632] Please enable it if your BIOS has the CPPC option. hub # [ 0.722762] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.724090] drop_monitor: Initializing network drop monitor service hub # [ 0.725208] NET: Registered PF_INET6 protocol family hub # [ 0.729097] Segment Routing with IPv6 hub # [ 0.731649] In-situ OAM (IOAM) with IPv6 hub # [ 0.732678] IPI shorthand broadcast: enabled hub # [ 0.740927] sched_clock: Marking stable (597014398, 143603033)->(823035404, -82417973) hub # [ 0.745870] registered taskstats version 1 hub # [ 0.746796] Loading compiled-in X.509 certificates hub # [ 0.765625] Demotion targets for Node 0: null hub # [ 0.766465] Key type .fscrypt registered hub # [ 0.767126] Key type fscrypt-provisioning registered hub # [ 0.768046] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.770630] ima: Allocated hash algorithm: sha1 hub # [ 0.771389] ima: No architecture policies found hub # [ 0.775630] PM: Magic number: 14:45:996 hub # [ 0.777230] RAS: Correctable Errors collector initialized. hub # [ 0.785351] clk: Disabling unused clocks hub # [ 0.789635] PM: genpd: Disabling unused power domains hub # [ 0.963327] Freeing initrd memory: 29608K hub # [ 0.966576] Freeing unused decrypted memory: 2028K hub # [ 0.969383] Freeing unused kernel image (initmem) memory: 3656K hub # [ 0.970424] Write protecting the kernel read-only data: 32768k hub # [ 0.971711] Freeing unused kernel image (text/rodata gap) memory: 304K hub # [ 0.973141] Freeing unused kernel image (rodata/data gap) memory: 692K hub # [ 1.023757] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.024806] Run /init as init process hub # [ 1.035710] systemd[1]: Inserted module 'autofs4' hub # [ 1.055757] fuse: init (API version 7.45) hub # [ 1.063083] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.065431] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.068424] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.070328] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 1.075444] virtiofs virtio5: discovered new tag: nix-store hub # [ 1.077000] virtiofs virtio5: virtio_fs_setup_dax: No cache capability hub # [ 1.083842] virtiofs virtio6: discovered new tag: shared hub # [ 1.085284] virtiofs virtio6: virtio_fs_setup_dax: No cache capability hub # [ 1.089520] virtiofs virtio7: discovered new tag: xchg hub # [ 1.091203] virtiofs virtio7: virtio_fs_setup_dax: No cache capability hub # [ 1.114447] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.450098] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) hub # [ 1.455173] systemd[1]: Detected virtualization kvm. hub # [ 1.456054] systemd[1]: Detected architecture x86-64. hub # [ 1.456975] systemd[1]: Running in initrd. hub # [ 1.458079] systemd[1]: Initializing machine ID from random generator. hub # [ 1.459285] systemd[1]: Hostname set to . hub # [ 1.529037] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.566330] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.570874] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.572059] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.573482] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.574627] systemd[1]: Reached target Path Units. hub # [ 1.575486] systemd[1]: Reached target Slice Units. hub # [ 1.576396] systemd[1]: Reached target Swaps. hub # [ 1.577236] systemd[1]: Reached target Timer Units. hub # [ 1.578247] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.579486] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.580707] systemd[1]: Listening on Journal Sockets. hub # [ 1.581709] systemd[1]: Listening on udev Control Socket. hub # [ 1.582733] systemd[1]: Listening on udev Kernel Socket. hub # [ 1.583687] systemd[1]: Reached target Socket Units. hub # [ 1.585372] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 1.590697] systemd[1]: Starting Load Kernel Module configfs... hub # [ 1.599202] systemd[1]: Starting Journal Service... hub # [ 1.622699] systemd[1]: Starting Load Kernel Modules... hub # [ 1.626724] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 1.633496] systemd[1]: Starting Coldplug All udev Devices... hub # [ 1.643755] systemd-journald[65]: Collecting audit messages is disabled. hub # [ 1.647062] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 1.655241] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 1.660990] systemd[1]: Finished Load Kernel Module configfs. hub # [ 1.666066] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 1.678687] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 1.686134] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 1.698945] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 1.720153] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 1.727801] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 1.739158] systemd[1]: Finished Load Kernel Modules. hub # [ 1.747835] systemd[1]: Starting Apply Kernel Variables... hub # [ 1.622287] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.766983] systemd[1]: Finished Create Static Device Nodes in /dev. hub # hub # [ 1.624534] systemd-modules-load[66]: Inserted module 'virtio_balloon' hub # [ 1.628326] systemd-modules-load[66]: Inserted module 'virtio_gpu' hub # [ 1.773693] systemd[1]: Started Journal Service. hub # [ 1.640177] systemd[1]: Finished Apply Kernel Variables. hub # [ 1.643081] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 1.644094] systemd[1]: Reached target Local File Systems. hub # [ 1.648086] systemd[1]: Starting Create System Files and Directories... hub # [ 1.653338] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 1.675337] systemd[1]: Finished Create System Files and Directories. hub # [ 1.698397] systemd-udevd[81]: Using default interface naming scheme 'v261'. hub # [ 1.723071] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 1.776135] systemd[1]: Finished Coldplug All udev Devices. hub # [ 1.778107] systemd[1]: Reached target System Initialization. hub # [ 1.778905] systemd[1]: Reached target Basic System. hub # [ 2.099850] virtio_blk virtio2: 1/0/0 default/read/poll queues hub # [ 2.101502] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 2.142737] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 2.143480] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 hub # [ 2.145175] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 hub # [ 2.147492] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.149362] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.150055] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.151765] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 2.154448] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 2.155553] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.159631] usb usb1: Product: EHCI Host Controller hub # [ 2.160302] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd hub # [ 2.162333] usb usb1: SerialNumber: 0000:00:1d.7 hub # [ 2.168789] hub 1-0:1.0: USB hub found hub # [ 2.169341] hub 1-0:1.0: 6 ports detected hub # [ 2.175993] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 2.176792] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 hub # [ 2.190933] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 2.198947] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 hub # [ 2.205738] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.074929] systemd[1]: Starting Virtual Console Setup... hub # [ 2.219351] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.220391] usb usb2: Product: UHCI Host Controller hub # [ 2.083574] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.085676] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.091249] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.238586] SCSI subsystem initialized hub # [ 2.251638] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 2.252375] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 2.119304] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.122066] systemd[1]: Finished Virtual Console Setup. hub # [ 2.272853] hub 2-0:1.0: USB hub found hub # [ 2.276238] hub 2-0:1.0: 2 ports detected hub # [ 2.282867] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.142542] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.143396] systemd[1]: Reached target Initrd Root Device. hub # [ 2.147082] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 2.300772] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 2.301503] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 2.310426] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 2.311671] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 hub # [ 2.316674] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.317807] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.322695] usb usb3: Product: UHCI Host Controller hub # [ 2.323393] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 2.181120] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.327649] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 2.328924] hub 3-0:1.0: USB hub found hub # [ 2.331625] hub 3-0:1.0: 2 ports detected hub # [ 2.334160] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 2.194389] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.340439] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 2.343640] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 2.344473] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 hub # [ 2.346307] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.348653] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.350648] usb usb4: Product: UHCI Host Controller hub # [ 2.351337] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 2.353654] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 2.355968] hub 4-0:1.0: USB hub found hub # [ 2.362552] hub 4-0:1.0: 2 ports detected hub # [ 2.396326] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 2.397995] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 2.399369] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 2.403308] scsi host0: ahci hub # [ 2.405016] scsi host1: ahci hub # [ 2.406649] scsi host2: ahci hub # [ 2.408374] scsi host3: ahci hub # [ 2.409638] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 2.411337] scsi host4: ahci hub # [ 2.412918] scsi host5: ahci hub # [ 2.413498] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 hub # [ 2.415584] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 hub # [ 2.416829] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 hub # [ 2.418031] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 hub # [ 2.419261] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 hub # [ 2.420442] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 hub # [ 2.540950] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 2.543911] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 2.547111] usb 1-1: Product: QEMU USB Tablet hub # [ 2.548904] usb 1-1: Manufacturer: QEMU hub # [ 2.550652] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 2.582034] hid: raw HID events driver (C) Jiri Kosina hub # [ 2.499911] systemd[1]: Mounting /sysroot... hub # [ 2.728167] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 2.729076] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 2.730094] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 2.731034] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 2.731971] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 2.732920] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 2.733724] ata3.00: applying bridge limits hub # [ 2.734398] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 2.735324] ata3.00: configured for UDMA/100 hub # [ 2.736324] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 2.790073] usbcore: registered new interface driver usbhid hub # [ 2.797033] usbhid: USB HID core driver hub # [ 2.824834] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 hub # [ 2.826748] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 hub # [ 2.843367] EXT4-fs (vda): mounted filesystem 5ac5da24-cb79-46c3-82b1-0a21b4f663ac r/w with ordered data mode. Quota mode: none. hub # [ 2.847323] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 2.706232] systemd[1]: Mounted /sysroot. hub # [ 2.708823] systemd[1]: Reached target Initrd Root File System. hub # [ 2.711287] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 2.864714] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 2.725801] systemd-sysroot-fstab-check[141]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 2.729334] systemd[1]: Reload requested from client PID 141 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 2.731708] systemd[1]: Reloading... hub # [ 2.817855] systemd[1]: Reloading finished in 86 ms. hub # [ 2.825942] systemd-sysroot-fstab-check[141]: Requesting initrd-fs.target/start/replace... hub # [ 2.830108] systemd-sysroot-fstab-check[141]: Requesting swap.target/start/replace... hub # [ 2.834580] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 2.836054] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 2.837156] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 3.504256] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 3.510201] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.518206] systemd[1]: Mounting /sysroot/run... hub # [ 3.530189] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 3.542342] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 3.576500] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.581333] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 3.585620] systemd[1]: Mounted /sysroot/run. hub # [ 3.590444] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.591823] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 3.596139] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 3.607895] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.609467] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.502678] systemd[1]: Mounting /sysroot/nix/store... hub # [ 4.550347] systemd[1]: Mounted /sysroot/nix/store. hub # [ 4.552499] systemd[1]: Reached target Initrd File Systems. hub # [ 4.554342] systemd[1]: Starting Find NixOS closure... hub # [ 4.557140] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 4.577402] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 4.584202] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 4.587491] systemd[1]: Finished Find NixOS closure. hub # [ 4.589181] systemd[1]: Reached target Initrd Default Target. hub # [ 4.590452] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 4.605234] systemd[1]: Stopped target Initrd Default Target. hub # [ 4.607051] systemd[1]: Stopped target Basic System. hub # [ 4.607789] systemd[1]: Stopped target Initrd Root Device. hub # [ 4.608555] systemd[1]: Stopped target Path Units. hub # [ 4.609224] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 4.610180] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 4.611186] systemd[1]: Stopped target Slice Units. hub # [ 4.611867] systemd[1]: Stopped target Socket Units. hub # [ 4.613147] systemd[1]: Stopped target System Initialization. hub # [ 4.614298] systemd[1]: Stopped target Swaps. hub # [ 4.615105] systemd[1]: Stopped target Timer Units. hub # [ 4.615940] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 4.617188] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.618752] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 4.619786] systemd[1]: Stopped Find NixOS closure. hub # [ 4.620846] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.621765] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 4.623157] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.624132] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 4.626305] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.628877] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.629979] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.630988] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.631940] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.632798] systemd[1]: Stopped target Local File Systems. hub # [ 4.633642] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.636456] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 4.637452] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 4.638243] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.639249] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 4.640172] systemd[1]: Stopped Virtual Console Setup. hub # [ 4.651700] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.655051] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 4.658143] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.660954] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 4.664069] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 4.665110] systemd[1]: Closed udev Control Socket. hub # [ 4.667085] systemd[1]: Starting Cleanup udev Database... hub # [ 4.667884] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.669051] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.669900] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.671020] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.672103] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.674115] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 4.674965] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 4.676364] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.692158] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.693742] systemd[1]: Finished Cleanup udev Database. hub # [ 4.695327] systemd[1]: Reached target Switch Root. hub # [ 4.697062] systemd[1]: Starting NixOS Activation... hub # [ 4.760920] initrd-nixos-activation-start[193]: booting system configuration /nix/store/mnbg0png64a8cr8c2s47gqqdpw0kypwv-nixos-system-hub-test hub # [ 4.786375] initrd-nixos-activation-start[193]: running activation script... hub # [ 5.165928] initrd-nixos-activation-start[216]: setting up /etc... hub # [ 5.275124] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 5.276699] systemd[1]: Finished NixOS Activation. hub # [ 5.278640] systemd[1]: Starting Switch Root... hub # [ 5.291206] systemd[1]: Switching root. hub # [ 5.557727] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). worker # Disk image does not exist, creating the virtualisation disk image... worker: QEMU running (pid 48) worker # Formatting '/build/vm-state-worker/tmp.xswZdib6nW', fmt=raw size=1073741824 worker # mke2fs 1.47.4 (6-Mar-2025) hub # [ 8.682071] NET: Registered PF_VSOCK protocol family worker # Discarding device blocks: 0/262144 done (finished: start all VMs, in 9.84 seconds) worker # Creating filesystem with 262144 4k blocks and 65536 inodes hub: waiting for unit headscale worker # Filesystem UUID: 4b2b9d6f-0324-4dfe-b511-2b92b03049d5 hub: waiting for the VM to finish booting worker # Superblock backups stored on blocks: worker # 32768, 98304, 163840, 229376 worker # worker # Allocating group tables: 0/8 done worker # Writing inode tables: 0/8 done worker # Creating journal (8192 blocks): done worker # Writing superblocks and filesystem accounting information: 0/8 done worker # worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. worker # Starting virtiofs daemons... worker # [2026-10-25T16:57:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) worker # [2026-10-25T16:57:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether worker # [2026-10-25T16:57:34Z INFO virtiofsd] Waiting for vhost-user socket connection... worker # [2026-10-25T16:57:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) worker # [2026-10-25T16:57:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether worker # [2026-10-25T16:57:34Z INFO virtiofsd] Waiting for vhost-user socket connection... worker # [2026-10-25T16:57:34Z INFO virtiofsd] Client connected, servicing requests worker # [2026-10-25T16:57:34Z INFO virtiofsd] Client connected, servicing requests worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) worker # worker # worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC610+7EF2C610 CA00 worker # Press Ctrl-B to configure iPXE (PCI 00:02.0)... worker # worker # worker # worker # worker # iPXE (http://ipxe.org) 00:06.0 CB00 PCI2.10 PnP PMM 7EFCC610 7EF2C610 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:06.0)... worker # worker # worker # Booting from ROM... hub # [ 9.048320] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) hub # [ 9.052406] systemd[1]: Detected virtualization kvm. hub # [ 9.053122] systemd[1]: Detected architecture x86-64. hub # [ 9.053928] systemd[1]: Detected first boot. hub # [ 9.056414] systemd[1]: Initializing machine ID from random generator. worker # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026 worker # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/bsvwnxj10jqs5ag807mb6g6kgrk58q7i-nixos-system-worker-test/init regInfo=/nix/.ro-store/ikns7n7n0pj8fygj57ly0xg71xjkxlq1-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd4fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd5000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved worker # [ 0.000000] NX (Execute Disable) protection: active worker # [ 0.000000] APIC: Static calls initialized worker # [ 0.000000] SMBIOS 2.8 present. worker # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 worker # [ 0.000000] DMI: Memory slots populated: 1/1 worker # [ 0.000000] Hypervisor detected: KVM worker # [ 0.000000] last_pfn = 0x7ffd5 max_arch_pfn = 0x10000000000 hub # [ 9.308936] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000000] kvm-clock: using sched offset of 699479744 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000005] tsc: Detected 2400.008 MHz processor worker # [ 0.000764] last_pfn = 0x7ffd5 max_arch_pfn = 0x10000000000 worker # [ 0.000790] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000793] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.002686] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.002697] Using GB pages for direct mapping worker # [ 0.002763] RAMDISK: [mem 0x7e284000-0x7ffcffff] worker # [ 0.002771] ACPI: Early table checksum verification disabled worker # [ 0.002774] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) worker # [ 0.002778] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002782] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002789] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002791] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002793] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002794] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002796] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002797] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002799] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d] worker # [ 0.002800] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219] worker # [ 0.002800] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002801] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385] worker # [ 0.002801] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd] worker # [ 0.002802] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9] worker # [ 0.002802] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421] worker # [ 0.003017] No NUMA configuration found worker # [ 0.003018] Faking a node at [mem 0x0000000000000000-0x000000007ffd4fff] worker # [ 0.003020] NODE_DATA(0) allocated [mem 0x7e27ea80-0x7e283fff] worker # [ 0.005180] Zone ranges: worker # [ 0.005181] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.005183] DMA32 [mem 0x0000000001000000-0x000000007ffd4fff] worker # [ 0.005184] Normal empty worker # [ 0.005184] Device empty worker # [ 0.005185] Movable zone start for each node worker # [ 0.005186] Early memory node ranges worker # [ 0.005186] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.005187] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.005188] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd4fff] worker # [ 0.005208] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.005457] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.039607] On node 0, zone DMA32: 43 pages in unavailable ranges worker # [ 0.040068] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.040082] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.040112] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.040115] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.040116] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.040117] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.040118] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.040119] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.040121] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.040122] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.040126] TSC deadline timer available worker # [ 0.040131] CPU topo: Max. logical packages: 1 worker # [ 0.040131] CPU topo: Max. logical dies: 1 worker # [ 0.040132] CPU topo: Max. dies per package: 1 worker # [ 0.040136] CPU topo: Max. threads per core: 1 worker # [ 0.040136] CPU topo: Num. cores per package: 1 worker # [ 0.040137] CPU topo: Num. threads per package: 1 worker # [ 0.040137] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.040158] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.040184] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.040185] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.040187] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.040188] Booting paravirtualized kernel on KVM worker # [ 0.040192] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.044826] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.046881] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.046928] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.046930] 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/bsvwnxj10jqs5ag807mb6g6kgrk58q7i-nixos-system-worker-test/init regInfo=/nix/.ro-store/ikns7n7n0pj8fygj57ly0xg71xjkxlq1-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.047023] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ikns7n7n0pj8fygj57ly0xg71xjkxlq1-closure-info/registration", will be passed to user space. worker # [ 0.047037] random: crng init done worker # [ 0.047037] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.049061] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.049084] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.049119] Fallback order for Node 0: 0 worker # [ 0.049122] Built 1 zonelists, mobility grouping on. Total pages: 524147 worker # [ 0.049123] Policy zone: DMA32 worker # [ 0.051450] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.055329] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.060501] allocated 4194304 bytes of page_ext worker # [ 0.070829] ftrace: allocating 48837 entries in 192 pages worker # [ 0.070831] ftrace: allocated 192 pages with 2 groups worker # [ 0.071711] Dynamic Preempt: lazy worker # [ 0.071885] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.071885] rcu: RCU event tracing is enabled. worker # [ 0.071886] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.071887] Trampoline variant of Tasks RCU enabled. worker # [ 0.071888] Rude variant of Tasks RCU enabled. worker # [ 0.071888] Tracing variant of Tasks RCU enabled. worker # [ 0.071889] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.071889] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.071912] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 9.387140] systemd[1]: Applying preset policy. worker # [ 0.071914] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.071914] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.076259] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.076551] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.076557] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.076660] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.080199] Console: colour VGA+ 80x25 worker # [ 0.080202] printk: legacy console [tty0] enabled worker # [ 0.110413] printk: legacy console [ttyS0] enabled worker # [ 0.216230] ACPI: Core revision 20250807 worker # [ 0.217205] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.218877] APIC: Switch to symmetric I/O mode setup worker # [ 0.219910] x2apic enabled worker # [ 0.220653] APIC: Switched APIC routing to: physical x2apic worker # [ 0.222498] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.223525] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns worker # [ 0.225280] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) worker # [ 0.226362] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.228417] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.229276] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.230280] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.231277] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.232277] Transient Scheduler Attacks: Vulnerable: No microcode worker # [ 0.233276] Spectre V2 : Mitigation: Enhanced / Automatic IBRS worker # [ 0.234277] Speculative Return Stack Overflow: Mitigation: Safe RET worker # [ 0.235276] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.237284] Spectre V2 : Enabling IBPB for BPF worker # [ 0.238842] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.239277] active return thunk: srso_alias_return_thunk worker # [ 0.240191] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.241276] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.242277] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.243277] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' worker # [ 0.244276] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' worker # [ 0.245276] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' worker # [ 0.247112] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' worker # [ 0.248277] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.249276] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 worker # [ 0.250277] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 worker # [ 0.251278] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 worker # [ 0.252277] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 worker # [ 0.254004] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. worker # [ 0.288637] Freeing SMP alternatives memory: 48K worker # [ 0.289279] pid_max: default: 32768 minimum: 301 worker # [ 0.290097] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.291321] landlock: Up and running. worker # [ 0.291921] Yama: becoming mindful. worker # [ 0.292489] LSM support for eBPF active worker # [ 0.293388] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.294314] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.296984] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) worker # [ 0.297805] Performance Events: Fam17h+ core perfctr, AMD PMU driver. worker # [ 0.298281] ... version: 2 worker # [ 0.299003] ... bit width: 48 worker # [ 0.299279] ... generic counters: 6 worker # [ 0.300022] ... generic bitmap: 000000000000003f worker # [ 0.300325] ... fixed-purpose counters: 0 worker # [ 0.301063] ... fixed-purpose bitmap: 0000000000000000 worker # [ 0.301279] ... value mask: 0000ffffffffffff worker # [ 0.302217] ... max period: 00007fffffffffff worker # [ 0.303008] ... global_ctrl mask: 000000000000003f worker # [ 0.303386] signal: max sigframe size: 3376 worker # [ 0.304193] rcu: Hierarchical SRCU implementation. worker # [ 0.304911] rcu: Max phase no-delay instances is 400. worker # [ 0.309810] smp: Bringing up secondary CPUs ... worker # [ 0.310292] smp: Brought up 1 node, 1 CPU worker # [ 0.310988] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) worker # [ 0.311432] Memory: 1968700K/2096588K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 118444K reserved, 0K cma-reserved) worker # [ 0.312519] devtmpfs: initialized worker # [ 0.313310] x86/mm: Memory block size: 128MB worker # [ 0.315215] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.316224] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). worker # [ 0.317344] pinctrl core: initialized pinctrl subsystem worker # [ 0.318477] PM: RTC time: 16:57:34, date: 2026-10-25 worker # [ 0.322585] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.323797] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations worker # [ 0.324302] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.325581] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.326288] audit: initializing netlink subsys (disabled) worker # [ 0.327281] audit: type=2000 audit(1792947455.127:1): state=initialized audit_enabled=0 res=1 worker # [ 0.328480] thermal_sys: Registered thermal governor 'fair_share' worker # [ 0.328482] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.329280] thermal_sys: Registered thermal governor 'step_wise' worker # [ 0.330280] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.331278] thermal_sys: Registered thermal governor 'power_allocator' worker # [ 0.332291] cpuidle: using governor menu worker # [ 0.334559] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 worker # [ 0.335551] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.336282] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.337291] PCI: Using configuration type 1 for base access worker # [ 0.338440] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. worker # [ 0.346303] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.347279] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page worker # [ 0.350284] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.351280] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page worker # [ 0.361718] ACPI: Added _OSI(Module Device) worker # [ 0.362280] ACPI: Added _OSI(Processor Device) worker # [ 0.363053] ACPI: Added _OSI(Processor Aggregator Device) worker # [ 0.371923] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.375678] ACPI: Interpreter enabled worker # [ 0.376294] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.377036] ACPI: Using IOAPIC for interrupt routing worker # [ 0.377360] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.378280] PCI: Using E820 reservations for host bridge windows worker # [ 0.381418] ACPI: Enabled 2 GPEs in block 00 to 3F worker # [ 0.388477] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) worker # [ 0.389288] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.390372] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.391407] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.392658] PCI host bridge to bus 0000:00 worker # [ 0.393283] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] worker # [ 0.394279] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.395279] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] worker # [ 0.396279] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.397279] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] worker # [ 0.398279] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] worker # [ 0.399280] pci_bus 0000:00: root bus resource [bus 00-ff] worker # [ 0.400271] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.401706] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.404404] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] worker # [ 0.405348] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.406307] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.407642] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.408995] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.411287] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.412117] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.412995] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.413286] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] worker # [ 0.414848] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.416310] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.417157] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] worker # [ 0.418132] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.419942] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.422287] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.423189] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] worker # [ 0.424072] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.425756] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.428310] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.429171] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.430034] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] worker # [ 0.430891] pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.432287] pci 0000:00:06.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 9.654127] systemd[1]: Populated /etc with preset unit settings. worker # [ 0.433203] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.434001] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.434284] pci 0000:00:06.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.435825] pci 0000:00:07.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint worker # [ 0.437730] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.438301] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.439823] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint worker # [ 0.441166] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] worker # [ 0.442001] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.442830] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint worker # [ 0.444473] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.445301] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] worker # [ 0.446834] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint worker # [ 0.448305] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] worker # [ 0.449134] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.450018] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.450819] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.452822] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.453285] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.454210] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.455661] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.456886] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] worker # [ 0.457518] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.458939] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] worker # [ 0.459509] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.460874] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] worker # [ 0.462248] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint worker # [ 0.465132] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.466555] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint worker # [ 0.467651] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO worker # [ 0.468632] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint worker # [ 0.471250] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] worker # [ 0.472024] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] worker # [ 0.473552] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.475232] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] worker # [ 0.479922] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.480424] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 worker # [ 0.481413] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.482407] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.483408] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.484407] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 worker # [ 0.485415] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.486409] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.487331] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.488299] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.489303] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.490299] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 0.491299] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.492299] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.493303] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.494300] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 0.496527] iommu: Default domain type: Translated worker # [ 0.497289] iommu: DMA domain TLB invalidation policy: lazy mode worker # [ 0.498594] ACPI: bus type USB registered worker # [ 0.499347] usbcore: registered new interface driver usbfs worker # [ 0.500235] usbcore: registered new interface driver hub worker # [ 0.500907] usbcore: registered new device driver usb worker # [ 0.502157] NetLabel: Initializing worker # [ 0.502683] NetLabel: domain hash size = 128 worker # [ 0.503278] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO worker # [ 0.504184] NetLabel: unlabeled traffic allowed by default worker # [ 0.504944] PCI: Using ACPI for IRQ routing worker # [ 0.548726] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.549275] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.549275] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.549285] vgaarb: loaded worker # [ 0.550108] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.550842] hpet0: 3 comparators, 64-bit 100.000000 MHz counter worker # [ 0.554415] clocksource: Switched to clocksource kvm-clock hub # [ 9.817268] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 9.818696] systemd[1]: Stopped initrd-switch-root.service. worker # [ 0.558382] VFS: Disk quotas dquot_6.6.0 hub # [ 9.821012] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 0.559074] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 9.823047] systemd[1]: Created slice Slice /system/getty. worker # [ 0.560549] pnp: PnP ACPI init hub # [ 9.824399] systemd[1]: Created slice User and Session Slice. worker # [ 0.561495] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 9.825335] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 0.562449] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 9.826630] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 0.564035] pnp: PnP ACPI: found 5 devices hub # [ 9.827688] systemd[1]: Expecting device /dev/hvc0... hub # [ 9.828371] systemd[1]: Expecting device /dev/ttyS0... hub # [ 9.829144] systemd[1]: Reached target Local Encrypted Volumes. hub # [ 9.830000] systemd[1]: Stopped target initrd-fs.target. hub # [ 9.830741] systemd[1]: Stopped target initrd-root-fs.target. hub # [ 9.831532] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 9.832398] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 9.833328] systemd[1]: Reached target Path Units. hub # [ 9.834046] systemd[1]: Reached target Remote File Systems. hub # [ 9.834857] systemd[1]: Reached target Slice Units. hub # [ 9.835541] systemd[1]: Reached target Swaps. worker # [ 0.571799] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.573273] clocksource: Switched to clocksource acpi_pm worker # [ 0.574320] NET: Registered PF_INET protocol family hub # [ 9.837259] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 0.575553] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 9.839557] systemd[1]: Listening on Process Core Dump Socket. hub # [ 9.841303] systemd[1]: Listening on Credential Encryption/Decryption. hub # [ 9.854555] systemd[1]: Listening on Factory Reset Management. hub # [ 9.855505] systemd[1]: Listening on Hostname Service Socket. worker # [ 0.593511] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 9.858093] systemd[1]: Starting Journal Log Access Socket... worker # [ 0.595784] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 9.860217] systemd[1]: Listening on Journal Audit Socket. worker # [ 0.597248] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.598839] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 9.862457] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 0.600128] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 9.863618] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 0.601404] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 9.864751] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 0.602748] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 9.866075] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 0.603895] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.605194] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.606215] NET: Registered PF_XDP protocol family hub # [ 9.869782] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 0.607097] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 9.870787] systemd[1]: Listening on udev Control Socket. worker # [ 0.608129] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 9.871642] systemd[1]: Listening on udev Varlink Socket. worker # [ 0.609095] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.610164] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 9.873720] systemd[1]: Mounting Huge Pages File System... worker # [ 0.611220] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 0.612255] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] hub # [ 9.875954] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 0.614038] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 0.616221] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 0.618248] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 9.882662] systemd[1]: Mounting Kernel Debug File System... worker # [ 0.620238] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 0.621874] PCI: CLS 0 bytes, default 64 worker # [ 0.622854] Trying to unpack rootfs image as initramfs... hub # [ 9.890875] systemd[1]: Mounting Kernel Trace File System... worker # [ 0.627259] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns hub # [ 9.899022] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 9.909774] systemd[1]: Starting Load Kernel Module configfs... hub # [ 9.914221] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm hub # [ 9.926746] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 0.669040] Initialise system trusted keyrings worker # [ 0.671918] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 9.938900] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse hub # [ 9.947816] systemd[1]: Mounting FUSE Control File System... worker # [ 0.692389] Key type asymmetric registered hub # [ 9.953944] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 0.695746] Asymmetric key parser 'x509' registered worker # [ 0.696601] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.699868] io scheduler mq-deadline registered worker # [ 0.700665] io scheduler kyber registered hub # [ 9.967406] systemd[1]: Starting Journal Service... worker # [ 0.704382] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.705685] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.709550] Linux agpgart interface v0.103 worker # [ 0.710277] ACPI: bus type drm_connector registered hub # [ 9.975662] systemd[1]: Starting Load Kernel Modules... worker # [ 0.715281] usbcore: registered new interface driver usbserial_generic worker # [ 0.716369] usbserial: USB Serial support registered for generic worker # [ 0.718754] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. worker # [ 0.718754] Please enable it if your BIOS has the CPPC option. worker # [ 0.721021] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 9.985273] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 0.724867] drop_monitor: Initializing network drop monitor service worker # [ 0.726094] NET: Registered PF_INET6 protocol family worker # [ 0.731060] Segment Routing with IPv6 worker # [ 0.731777] In-situ OAM (IOAM) with IPv6 worker # [ 0.735029] IPI shorthand broadcast: enabled hub # [ 9.998659] systemd[1]: Starting Remount Root and Kernel File Systems... hub # [ 10.001144] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 10.006710] systemd[1]: Starting Coldplug All udev Devices... worker # [ 0.743240] sched_clock: Marking stable (599016287, 143718463)->(826202291, -83467541) worker # [ 0.745821] registered taskstats version 1 worker # [ 0.746855] Loading compiled-in X.509 certificates hub # [ 10.019328] systemd[1]: Listening on Journal Log Access Socket. hub # [ 10.023458] systemd[1]: Mounted Huge Pages File System. hub # [ 10.024738] systemd-journald[286]: Collecting audit messages is enabled. hub # [ 10.026903] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 0.765740] Demotion targets for Node 0: null worker # [ 0.766605] Key type .fscrypt registered worker # [ 0.769739] Key type fscrypt-provisioning registered worker # [ 0.770747] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.773762] ima: Allocated hash algorithm: sha1 worker # [ 0.774580] ima: No architecture policies found hub # [ 10.038783] systemd[1]: Mounted Kernel Debug File System. worker # [ 0.776748] PM: Magic number: 14:45:996 worker # [ 0.778495] RAS: Correctable Errors collector initialized. hub # [ 10.043760] systemd[1]: Mounted Kernel Trace File System. hub # [ 10.050030] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 0.787671] clk: Disabling unused clocks worker # [ 0.790764] PM: genpd: Disabling unused power domains hub # [ 10.055220] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 10.063173] systemd[1]: Finished Load Kernel Module configfs. hub # [ 9.923721] systemd[1]: Queued start job for default target Multi-User System. hub # [ 10.069460] systemd[1]: Started Journal Service. hub # [ 9.929386] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 10.076671] loop: module loaded hub # [ 9.936311] systemd[1]: Mounted FUSE Control File System. hub # [ 9.940347] systemd-modules-load[287]: Inserted module 'loop' hub # [ 9.960138] systemd[1]: Mounting Kernel Configuration File System... hub # [ 9.965496] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 9.966692] systemd-modules-load[287]: Inserted module 'tls' hub # [ 10.112925] EXT4-fs (vda): re-mounted 5ac5da24-cb79-46c3-82b1-0a21b4f663ac. hub # [ 9.984065] systemd[1]: Finished Load Kernel Modules. hub # [ 9.991531] systemd[1]: Starting Firewall... hub # [ 9.998096] systemd[1]: Starting Apply Kernel Variables... hub # [ 9.999965] systemd-oomd[289]: No swap; memory pressure usage will be degraded hub # [ 10.007108] systemd[1]: Finished Remount Root and Kernel File Systems. hub # [ 10.008184] systemd[1]: Listening on Disk Image Download Service Socket. hub # [ 10.025786] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 10.029156] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 10.036934] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 10.037906] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 10.040179] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 0.974304] Freeing initrd memory: 30000K worker # [ 0.977575] Freeing unused decrypted memory: 2028K hub # [ 10.098974] systemd[1]: Mounted Kernel Configuration File System. worker # [ 0.980345] Freeing unused kernel image (initmem) memory: 3656K worker # [ 0.981437] Write protecting the kernel read-only data: 32768k worker # [ 0.982797] Freeing unused kernel image (text/rodata gap) memory: 304K worker # [ 0.984345] Freeing unused kernel image (rodata/data gap) memory: 692K hub # [ 10.250138] systemd-journald[286]: Received client request to flush runtime journal. worker # [ 1.035252] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.036353] Run /init as init process worker # [ 1.047582] systemd[1]: Inserted module 'autofs4' worker # [ 1.067753] fuse: init (API version 7.45) worker # [ 1.075344] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.077777] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.080936] ACPI: \_SB_.GSIE: Enabled at IRQ 20 worker # [ 1.082894] ACPI: \_SB_.GSIF: Enabled at IRQ 21 worker # [ 1.089752] virtiofs virtio6: discovered new tag: shared worker # [ 1.091291] virtiofs virtio6: virtio_fs_setup_dax: No cache capability worker # [ 1.098134] virtiofs virtio7: discovered new tag: xchg worker # [ 1.099834] virtiofs virtio7: virtio_fs_setup_dax: No cache capability worker # [ 1.125001] systemd[1]: Successfully made /usr/ read-only. hub # [ 10.527908] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 10.530747] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 10.532809] systemd[1]: Finished Apply Kernel Variables. hub # [ 10.534664] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 10.535728] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 10.537176] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 10.538714] systemd[1]: Finished Coldplug All udev Devices. hub # [ 10.540299] systemd-udevd[322]: Using default interface naming scheme 'v261'. hub # [ 10.541705] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 10.543313] systemd[1]: Finished Load/Save OS Random Seed. hub # [ 10.544256] systemd[1]: Reached target First Boot Complete. hub # [ 10.545359] systemd[1]: Finished Flush Journal to Persistent Storage. hub # [ 10.547925] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 1.460875] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) worker # [ 1.466350] systemd[1]: Detected virtualization kvm. worker # [ 1.467367] systemd[1]: Detected architecture x86-64. worker # [ 1.468329] systemd[1]: Running in initrd. worker # [ 1.469576] systemd[1]: Initializing machine ID from random generator. worker # [ 1.470931] systemd[1]: Hostname set to . hub # [ 10.639097] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 1.550573] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 10.680224] systemd[1]: Mounting /run/wrappers... hub # [ 10.687245] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 10.707243] (udev-worker)[348]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 10.710223] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line. worker # [ 1.594173] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 10.716364] (udev-worker)[357]: Network interface NamePolicy= disabled on kernel command line. worker # [ 1.598324] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.599579] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.601075] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.602291] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.603429] systemd[1]: Reached target Path Units. worker # [ 1.604347] systemd[1]: Reached target Slice Units. worker # [ 1.605271] systemd[1]: Reached target Swaps. hub # [ 10.725403] systemd[1]: Mounted /run/wrappers. worker # [ 1.606098] systemd[1]: Reached target Timer Units. hub # [ 10.726506] systemd[1]: Reached target Local File Systems. worker # [ 1.607122] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 1.608438] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 1.609679] systemd[1]: Listening on Journal Sockets. worker # [ 1.610777] systemd[1]: Listening on udev Control Socket. hub # [ 10.730402] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 1.611855] systemd[1]: Listening on udev Kernel Socket. worker # [ 1.612865] systemd[1]: Reached target Socket Units. worker # [ 1.615214] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 10.736152] systemd[1]: Starting register-nix-paths.service... worker # [ 1.620844] systemd[1]: Starting Load Kernel Module configfs... hub # [ 10.743292] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 10.746069] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 10.751640] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 1.630860] systemd[1]: Starting Journal Service... hub # [ 10.768178] systemd[1]: Starting Create System Files and Directories... worker # [ 1.660608] systemd[1]: Starting Load Kernel Modules... worker # [ 1.661675] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.676830] systemd[1]: Starting Coldplug All udev Devices... worker # [ 1.690775] systemd-journald[65]: Collecting audit messages is disabled. worker # [ 1.693822] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 1.702955] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 1.708832] systemd[1]: Finished Load Kernel Module configfs. worker # [ 1.714323] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config worker # [ 1.729054] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 1.742144] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 1.753065] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 1.793900] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 1.801799] systemd[1]: Finished Load Kernel Modules. hub # [ 10.921428] systemd[1]: Finished Create System Files and Directories. worker # [ 1.809063] systemd[1]: Starting Apply Kernel Variables... hub # [ 10.935492] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 10.942131] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 1.676583] systemd-modules-load[66]: Inserted module 'dm_mod' worker # [ 1.680342] systemd-modules-load[66]: Inserted module 'virtio_balloon' worker # [ 1.681558] systemd-modules-load[66]: Inserted module 'virtio_gpu' worker # [ 1.826885] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 1.834002] systemd[1]: Started Journal Service. worker # [ 1.725565] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 1.729129] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 1.730250] systemd[1]: Reached target Local File Systems. worker # [ 1.735080] systemd[1]: Starting Create System Files and Directories... worker # [ 1.739579] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 1.749084] systemd[1]: Finished Apply Kernel Variables. worker # [ 1.779426] systemd[1]: Finished Create System Files and Directories. hub # [ 11.048375] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 1.805449] systemd-udevd[79]: Using default interface naming scheme 'v261'. hub # [ 11.090621] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 1.830257] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 11.097585] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 11.114197] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore hub # [ 11.117169] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 11.120153] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 hub # [ 11.123507] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 11.125239] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 11.126845] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.868817] systemd[1]: Finished Coldplug All udev Devices. worker # [ 1.869891] systemd[1]: Reached target System Initialization. worker # [ 1.870753] systemd[1]: Reached target Basic System. hub # [ 11.267234] systemd[1]: Starting Update is Completed... hub # [ 11.490960] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 2.229892] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 11.357080] systemd[1]: Finished Update is Completed. worker # [ 2.242895] serio: i8042 KBD port at 0x60,0x64 irq 1 worker # [ 2.243692] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 11.506925] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 2.248890] virtio_blk virtio2: 1/0/0 default/read/poll queues worker # [ 2.261927] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 11.528437] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 hub # [ 11.539480] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input3 worker # [ 2.284159] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 2.285059] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 worker # [ 2.287023] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 worker # [ 2.294900] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 2.297889] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 2.299081] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.302761] usb usb1: Product: EHCI Host Controller worker # [ 2.303477] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd worker # [ 2.305934] virtio_blk virtio3: 1/0/0 default/read/poll queues worker # [ 2.306781] usb usb1: SerialNumber: 0000:00:1d.7 worker # [ 2.307805] hub 1-0:1.0: USB hub found worker # [ 2.309935] hub 1-0:1.0: 6 ports detected worker # [ 2.313745] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 2.314476] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 worker # [ 2.318692] virtio_blk virtio3: [vdb] 2156872 512-byte logical blocks (1.10 GB/1.03 GiB) worker # [ 2.329163] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 2.335329] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 worker # [ 2.346318] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.205166] systemd[1]: Starting Virtual Console Setup... worker # [ 2.360698] SCSI subsystem initialized worker # [ 2.373780] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.250348] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 2.253569] systemd[1]: Finished Virtual Console Setup. worker # [ 2.399806] usb usb2: Product: UHCI Host Controller worker # [ 2.400559] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd worker # [ 2.260561] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.406412] usb usb2: SerialNumber: 0000:00:1d.0 worker # [ 2.263927] (udev-worker)[87]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.266886] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.415804] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.422805] hub 2-0:1.0: USB hub found worker # [ 2.424331] hub 2-0:1.0: 2 ports detected worker # [ 2.443147] uhci_hcd 0000:00:1d.1: UHCI Host Controller worker # [ 2.443971] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 worker # [ 2.314692] systemd[1]: Found device /dev/disk/by-label/nix-store. worker # [ 2.461813] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 2.462618] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 worker # [ 2.321872] systemd[1]: Found device /dev/disk/by-label/nixos. worker # [ 2.325889] systemd[1]: Reached target Initrd Root Device. worker # [ 2.327063] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.472872] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.478244] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.479434] usb usb3: Product: UHCI Host Controller worker # [ 2.480211] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd worker # [ 2.486667] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 2.488831] hub 3-0:1.0: USB hub found worker # [ 2.490032] hub 3-0:1.0: 2 ports detected worker # [ 2.498127] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 2.499764] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 2.502840] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 2.503672] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 hub # [ 11.625438] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 2.507047] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 11.627619] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 2.509765] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.512930] usb usb4: Product: UHCI Host Controller worker # [ 2.513683] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd hub # [ 11.582665] ACPI: button: Power Button [PWRF] hub # [ 11.592934] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 2.374637] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.521997] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 2.523232] hub 4-0:1.0: USB hub found worker # [ 2.525755] hub 4-0:1.0: 2 ports detected hub # [ 11.593045] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD hub # [ 11.656435] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 hub # [ 11.657303] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 2.548996] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 2.550117] usb 1-1: new high-speed USB device number 2 using ehci-pci worker # [ 2.553102] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 2.553976] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 2.557874] scsi host0: ahci hub # [ 11.712008] mousedev: PS/2 mouse device common for all mice worker # [ 2.559537] scsi host1: ahci hub # [ 11.731411] rtc_cmos PNP0B00:00: RTC can wake from S4 hub # [ 11.763349] rtc_cmos PNP0B00:00: registered as rtc0 worker # [ 2.561670] scsi host2: ahci worker # [ 2.563335] scsi host3: ahci worker # [ 2.565005] scsi host4: ahci worker # [ 2.566655] scsi host5: ahci worker # [ 2.567699] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 46 lpm-pol 1 worker # [ 2.569368] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 46 lpm-pol 1 worker # [ 2.570552] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 46 lpm-pol 1 worker # [ 2.571739] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 46 lpm-pol 1 worker # [ 2.572829] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 46 lpm-pol 1 worker # [ 2.574026] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 46 lpm-pol 1 hub # [ 11.763420] rtc_cmos PNP0B00:00: setting system clock to 2026-10-25T16:57:37 UTC (1792947457) hub # [ 11.763509] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 11.780711] Console: switching to colour dummy device 80x25 hub # [ 11.792449] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 2.474600] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 11.744938] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 11.749714] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 11.792543] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 11.929492] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 11.929495] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 2.679807] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 2.682031] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 2.684423] usb 1-1: Product: QEMU USB Tablet worker # [ 2.685872] usb 1-1: Manufacturer: QEMU worker # [ 2.687149] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 2.548938] systemd[1]: Mounting /sysroot... hub # [ 11.964704] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 2.723657] hid: raw HID events driver (C) Jiri Kosina hub # [ 11.847823] systemd[1]: Finished Firewall. hub # [ 11.965556] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 hub # [ 11.861769] systemd[1]: Starting Virtual Console Setup... hub # [ 11.886609] systemd[1]: Finished register-nix-paths.service. hub # [ 11.901481] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 11.904215] systemd[1]: Stopped Virtual Console Setup. hub # [ 12.054539] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # [ 11.912754] systemd[1]: Starting Virtual Console Setup... hub # [ 12.096081] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) hub # [ 12.111934] ppdev: user-space parallel port driver hub # [ 12.130305] Console: switching to colour frame buffer device 160x50 hub # [ 12.144351] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device hub # [ 12.004845] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 2.885188] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 12.007093] systemd[1]: Stopped Virtual Console Setup. worker # [ 2.887565] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 2.889930] ata3.00: applying bridge limits worker # [ 2.891871] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 12.013672] systemd[1]: Starting Virtual Console Setup... worker # [ 2.894108] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 2.896158] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 2.898497] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 2.900802] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 2.902968] ata3.00: configured for UDMA/100 worker # [ 2.905322] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 worker # [ 2.988844] usbcore: registered new interface driver usbhid worker # [ 2.989607] usbhid: USB HID core driver hub # [ 12.253607] kvm_amd: TSC scaling supported hub # [ 12.254115] kvm_amd: Nested Virtualization enabled hub # [ 12.255042] kvm_amd: Nested Paging enabled worker # [ 2.991976] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 12.255533] kvm_amd: LBR virtualization supported hub # [ 12.256388] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 12.257172] kvm_amd: Virtual GIF supported hub # [ 12.257809] kvm_amd: Virtual NMI enabled worker # [ 3.009811] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.016944] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 worker # [ 3.020689] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 hub # [ 12.288877] EDAC MC: Ver: 3.0.0 hub # [ 12.221426] systemd-vconsole-setup[531]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 12.225574] systemd[1]: Finished Virtual Console Setup. hub # [ 12.226915] systemd[1]: Reached target System Initialization. hub # [ 12.228627] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 12.230056] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 12.231133] systemd[1]: Reached target Timer Units. hub # [ 12.233061] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 12.234322] systemd[1]: Listening on Nix Daemon Socket. hub # [ 12.235223] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 12.236546] systemd[1]: Reached target Socket Units. hub # [ 12.237406] systemd[1]: Reached target Basic System. hub # [ 12.239577] systemd[1]: Started backdoor.service. hub # [ 12.243583] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 3.126573] EXT4-fs (vda): mounted filesystem 4b2b9d6f-0324-4dfe-b511-2b92b03049d5 r/w with ordered data mode. Quota mode: none. worker # [ 2.986249] systemd[1]: Mounted /sysroot. hub # [ 12.249773] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 2.987658] systemd[1]: Reached target Initrd Root File System. worker # [ 2.990744] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 2.993521] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 12.256742] systemd[1]: Starting Post-Boot Actions... worker # [ 2.998167] systemd[1]: Mounting /sysroot/run... hub # [ 12.264829] systemd[1]: Started Reset console on configuration changes. worker # [ 3.003296] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.008137] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 12.275619] systemd[1]: Starting resolvconf update... worker # [ 3.016151] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 12.303179] systemd[1]: Starting D-Bus System Message Bus... worker # [ 3.043617] systemd-sysroot-fstab-check[150]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.052939] systemd[1]: Mounted /sysroot/run. worker # [ 3.055237] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # connecting to host... worker # [ 3.201796] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 3.059204] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.064208] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.065281] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.068960] systemd[1]: Reload requested from client PID 150 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.070469] systemd[1]: Reloading... hub # [ 12.333808] nsncd[537]: Oct 25 16:57:38.213 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 12.339073] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 12.342175] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 12.343277] systemd[1]: Reached target User and Group Name Lookups. hub # [ 12.361640] systemd[1]: Starting User Login Management... hub: Guest shell says: b'Spawning backdoor root shell...\n' hub # [ 12.366090] systemd[1]: Finished Post-Boot Actions. hub: connected to guest root shell hub: (connecting took 3.85 seconds) hub: (finished: waiting for the VM to finish booting, in 3.85 seconds) worker # [ 3.137054] systemd[1]: Reloading finished in 68 ms. hub # [ 12.402439] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 3.145801] systemd-sysroot-fstab-check[150]: Requesting initrd-fs.target/start/replace... worker # [ 3.149135] systemd-sysroot-fstab-check[150]: Requesting swap.target/start/replace... worker # [ 3.150629] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.154475] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.156123] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.158164] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.167740] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.169343] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 12.467882] dbus-broker-launch[544]: Looking up NSS user entry for 'systemd-timesync'... hub # [ 12.481958] dbus-broker-launch[544]: NSS returned no entry for 'systemd-timesync' hub # [ 12.483764] dbus-broker-launch[544]: Invalid user-name in /nix/store/rrr8bbsz3ff83qxf0g8ry1s9cgiz6akx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" hub # [ 12.505337] systemd-logind[559]: New seat seat0. hub # [ 12.508389] systemd[1]: Started D-Bus System Message Bus. hub # [ 12.516839] systemd-logind[559]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 12.518194] systemd-logind[559]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) hub # [ 12.520850] systemd-logind[559]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) hub # [ 12.522710] systemd[1]: Started User Login Management. hub # [ 12.529654] systemd[1]: Starting linger-users.service... hub # [ 12.552185] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 12.553499] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 12.555909] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 12.557937] systemd[1]: Stopping User and Group Name Lookups... hub # [ 12.560324] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 12.561924] dbus-broker-launch[544]: Ready hub # [ 12.568838] systemd[1]: nscd.service: Deactivated successfully. hub # [ 12.570904] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 12.599209] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 12.604077] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 12.606340] systemd[1]: Finished linger-users.service. hub # [ 12.631473] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 12.633746] nsncd[626]: Oct 25 16:57:38.513 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 12.637580] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 12.638743] systemd[1]: Reached target User and Group Name Lookups. hub # [ 12.640768] systemd[1]: Finished resolvconf update. hub # [ 12.642526] systemd[1]: Reached target Preparation for Network. hub # [ 12.647075] systemd[1]: Starting DHCP Client... hub # [ 12.650286] systemd[1]: Starting Address configuration of eth1... hub # [ 12.655910] systemd[1]: Starting Extra networking commands.... hub # [ 12.661934] systemd[1]: Starting Tailscale node agent... hub # [ 12.760450] network-addresses-eth1-start[646]: adding address 192.168.1.1/24... done hub # [ 12.784181] network-addresses-eth1-start[646]: adding address 2001:db8:1::1/64... done worker # [ 3.547187] systemd[1]: Mounting /sysroot/nix/store... hub # [ 12.812934] systemd[1]: Finished Address configuration of eth1. worker # [ 3.575995] systemd[1]: Mounted /sysroot/nix/store. worker # [ 3.577784] systemd[1]: Reached target Initrd File Systems. worker # [ 3.581188] systemd[1]: Starting Find NixOS closure... worker # [ 3.585159] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 12.869755] dhcpcd[660]: dhcpcd-10.3.2 starting worker # [ 3.608344] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 3.610618] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. hub # [ 12.881481] dhcpcd[715]: dev: loaded udev worker # [ 3.619471] systemd[1]: Finished Find NixOS closure. worker # [ 3.620696] systemd[1]: Reached target Initrd Default Target. worker # [ 3.622466] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 3.635735] systemd[1]: Stopped target Initrd Default Target. worker # [ 3.637041] systemd[1]: Stopped target Basic System. worker # [ 3.637944] systemd[1]: Stopped target Initrd Root Device. hub # [ 12.901526] systemd[1]: Finished Extra networking commands.. worker # [ 3.638932] systemd[1]: Stopped target Path Units. worker # [ 3.640106] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 3.641237] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 12.904797] systemd[1]: Reached target Network. worker # [ 3.642545] systemd[1]: Stopped target Slice Units. hub # [ 13.049972] 8021q: 802.1Q VLAN Support v1.8 worker # [ 3.643478] systemd[1]: Stopped target Socket Units. hub # [ 13.050491] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 3.644620] systemd[1]: Stopped target System Initialization. worker # [ 3.646219] systemd[1]: Stopped target Swaps. worker # [ 3.646873] systemd[1]: Stopped target Timer Units. worker # [ 3.647577] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 12.910851] systemd[1]: Starting Nginx Web Server... worker # [ 3.648379] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 3.649811] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 3.650848] systemd[1]: Stopped Find NixOS closure. worker # [ 3.651901] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.652794] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 12.916278] tailscaled[648]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 3.654311] systemd[1]: Stopped Apply Kernel Variables. worker # [ 3.655283] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 3.656504] systemd[1]: Stopped Load Kernel Modules. hub # [ 12.920879] systemd[1]: Starting Permit User Sessions... worker # [ 3.658313] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 3.659568] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 3.660840] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 3.662115] systemd[1]: Stopped Create System Files and Directories. worker # [ 3.663082] systemd[1]: Stopped target Local File Systems. worker # [ 3.664124] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 3.665852] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 3.668144] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 3.668899] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 3.669872] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 3.671020] systemd[1]: Stopped Virtual Console Setup. hub # [ 12.940744] tailscaled[648]: Program starting: v1.102.5, Go 1.26.8: []string{"/nix/store/8isnvnbq4q8qh2303rq8mvxsphx4akzn-tailscale-1.102.5/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} worker # [ 3.680383] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 12.944097] tailscaled[648]: LogID: ba4ca9504ec189ed89ae2557b84329deed2aba443a85de12bc841675ba556af4 hub # [ 12.945401] tailscaled[648]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 12.946520] tailscaled[648]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 3.685856] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 12.948460] tailscaled[648]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 3.690383] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 3.693200] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 3.695083] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 3.697922] systemd[1]: Closed udev Control Socket. worker # [ 3.698910] systemd[1]: Starting Cleanup udev Database... worker # [ 3.699733] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 3.700885] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 3.702234] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 3.703507] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 3.704648] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 3.706134] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 3.707024] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.709419] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 12.982419] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 3.725846] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 3.727637] systemd[1]: Finished Cleanup udev Database. worker # [ 3.729211] systemd[1]: Reached target Switch Root. worker # [ 3.731076] systemd[1]: Starting NixOS Activation... hub # [ 12.999146] tailscaled[648]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:50050->[::1]:53: read: connection refused (in 18ms), trying bootstrap... hub # [ 13.004386] dbus-broker-launch[544]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. hub # [ 13.014070] tailscaled[648]: trying bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" ... hub # [ 13.015585] tailscaled[648]: bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.65:443: connect: network is unreachable hub # [ 13.018383] tailscaled[648]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ... hub # [ 13.019947] tailscaled[648]: bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::e1f:4001]:443: connect: network is unreachable hub # [ 13.022975] tailscaled[648]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ... hub # [ 13.024474] tailscaled[648]: bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 64.225.56.166:443: connect: network is unreachable hub # [ 13.030280] tailscaled[648]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... hub # [ 13.032165] tailscaled[648]: 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 unreachable hub # [ 13.035504] tailscaled[648]: trying bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" ... hub # [ 13.036971] tailscaled[648]: bootstrapDNS("derp7.tailscale.com", "167.179.89.145") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 167.179.89.145:443: connect: network is unreachable hub # [ 13.041103] tailscaled[648]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... hub # [ 13.042731] tailscaled[648]: bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7a0:e001]:443: connect: network is unreachable hub # [ 13.048344] systemd[1]: Finished Permit User Sessions. hub # [ 13.049252] tailscaled[648]: trying bootstrapDNS("derp9c.tailscale.com", "155.138.243.219") for "log.tailscale.com" ... worker # [ 3.788292] initrd-nixos-activation-start[194]: booting system configuration /nix/store/bsvwnxj10jqs5ag807mb6g6kgrk58q7i-nixos-system-worker-test hub # [ 13.050744] tailscaled[648]: 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 unreachable hub # [ 13.053519] tailscaled[648]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ... hub # [ 13.058078] tailscaled[648]: bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f]:443: connect: network is unreachable hub # [ 13.061437] tailscaled[648]: trying bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" ... hub # [ 13.062933] tailscaled[648]: bootstrapDNS("derp12b.tailscale.com", "45.63.71.144") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 45.63.71.144:443: connect: network is unreachable hub # [ 13.065794] tailscaled[648]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ... hub # [ 13.067447] tailscaled[648]: bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::e1f:4001]:443: connect: network is unreachable hub # [ 13.070443] tailscaled[648]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... worker # [ 3.808388] initrd-nixos-activation-start[194]: running activation script... hub # [ 13.075385] tailscaled[648]: bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.74.153:443: connect: network is unreachable hub # [ 13.077854] tailscaled[648]: trying bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" ... hub # [ 13.079244] tailscaled[648]: bootstrapDNS("derp4e.tailscale.com", "2a03:b0c0:3:d0::29:9001") for "log.tailscale.com" error: Get "https://derp4e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:3:d0::29:9001]:443: connect: network is unreachable hub # [ 13.081883] tailscaled[648]: logtail: upload: log upload of 467 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/8879612c9fff0e257dc6c077a6380dcdd6d9d4be62811a464fa97bf79d29756d": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" hub # [ 13.085468] systemd[1]: Started Getty on tty1. hub # [ 13.088119] systemd[1]: Reached target Login Prompts. hub # [ 13.144459] tailscaled[648]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 13.145639] tailscaled[648]: dns: using "openresolv" mode hub # [ 13.146753] tailscaled[648]: dns: using dns.openresolvManager hub # [ 13.291705] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 13.324671] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 13.325397] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 13.329524] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 13.330398] cfg80211: failed to load regulatory.db worker # [ 3.947836] initrd-nixos-activation-start[217]: setting up /etc... hub # [ 13.250627] nginx-pre-start[732]: nginx: the configuration file /nix/store/4rhqvbnqc386vqy3k7bh2dys0824zniz-nginx.conf syntax is ok hub # [ 13.253354] nginx-pre-start[732]: nginx: configuration file /nix/store/4rhqvbnqc386vqy3k7bh2dys0824zniz-nginx.conf test is successful hub # [ 13.404472] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 13.263269] dhcpcd[715]: eth0: waiting for carrier hub # [ 13.263973] dhcpcd[715]: eth0: carrier acquired hub # [ 13.267186] systemd[1]: Started Nginx Web Server. hub # [ 13.277869] dhcpcd[715]: DUID 00:01:00:01:32:70:f1:83:52:54:00:12:34:56 hub # [ 13.278834] dhcpcd[715]: eth0: IAID 00:12:34:56 worker # [ 4.016176] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 13.279788] dhcpcd[715]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 4.018077] systemd[1]: Finished NixOS Activation. worker # [ 4.019914] systemd[1]: Starting Switch Root... worker # [ 4.033156] systemd[1]: Switching root. hub # [ 13.368096] tailscaled[648]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found hub # [ 13.372073] tailscaled[648]: wgengine.NewUserspaceEngine(tun "tailscale0") ... hub # [ 13.373073] systemd[1]: Started Tailscale node agent. hub # [ 13.525183] tun: Universal TUN/TAP device driver, 1.6 hub # [ 13.414246] tailscaled[648]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 13.415356] tailscaled[648]: dns: using "openresolv" mode hub # [ 13.426232] tailscaled[648]: dns: using dns.openresolvManager worker # [ 4.307624] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). hub # [ 13.428418] tailscaled[648]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} hub # [ 13.431741] tailscaled[648]: magicsock: disco key = d:9df9d40a0cbd055d hub # [ 13.433081] tailscaled[648]: Creating WireGuard device... hub # [ 13.435202] tailscaled[648]: Bringing WireGuard device up... hub # [ 13.436437] tailscaled[648]: Bringing router up... hub # [ 13.437534] tailscaled[648]: router: using firewall mode pref hub # [ 13.441703] tailscaled[648]: router: portUpdate(port=41641, network=udp6) hub # [ 13.444543] tailscaled[648]: external route: up hub # [ 13.461448] (udev-worker)[782]: Network interface NamePolicy= disabled on kernel command line. hub # [ 13.471430] tailscaled[648]: router: default choosing iptables hub # [ 13.492075] tailscaled[648]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 13.495067] tailscaled[648]: Clearing router settings... hub # [ 13.495995] tailscaled[648]: Starting network monitor... hub # [ 13.497152] tailscaled[648]: Engine created. hub # [ 13.500509] tailscaled[648]: router: portUpdate(port=41641, network=udp4) hub # [ 13.850959] tailscaled[648]: pm: migrating "_daemon" profile to new format hub # [ 13.855380] tailscaled[648]: envknob: PORT="41641" hub # [ 13.861644] tailscaled[648]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 13.864486] tailscaled[648]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 13.869812] tailscaled[648]: got LocalBackend in 498ms hub # [ 13.872453] tailscaled[648]: Start hub # [ 13.874462] tailscaled[648]: ipnext: "conn25": skipping extension hub # [ 13.877543] tailscaled[648]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop hub # [ 13.887376] tailscaled[648]: profile data directory: profile not found hub # [ 13.890875] tailscaled[648]: Backend: logs: be:ba4ca9504ec189ed89ae2557b84329deed2aba443a85de12bc841675ba556af4 fe: hub # [ 13.895484] tailscaled[648]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 13.899802] tailscaled[648]: blockEngineUpdates(true) hub # [ 13.904245] tailscaled[648]: wgengine: Reconfig: configuring router hub # [ 13.906715] tailscaled[648]: wgengine: Reconfig: user dialer hub # [ 13.908865] tailscaled[648]: wgengine: Reconfig: configuring DNS hub # [ 13.911090] tailscaled[648]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 13.913713] tailscaled[648]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 13.916870] tailscaled[648]: dns: OScfg: {} hub # [ 13.919266] tailscaled[648]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 4.836786] NET: Registered PF_VSOCK protocol family worker # [ 5.190065] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) worker # [ 5.193876] systemd[1]: Detected virtualization kvm. worker # [ 5.194533] systemd[1]: Detected architecture x86-64. worker # [ 5.195274] systemd[1]: Detected first boot. worker # [ 5.196319] systemd[1]: Initializing machine ID from random generator. worker # [ 5.282081] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 5.401834] systemd[1]: Applying preset policy. worker # [ 5.525087] systemd[1]: Populated /etc with preset unit settings. worker # [ 5.630253] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 5.631810] systemd[1]: Stopped initrd-switch-root.service. worker # [ 5.634130] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 5.636217] systemd[1]: Created slice Slice /system/getty. worker # [ 5.637692] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 5.639313] systemd[1]: Created slice User and Session Slice. worker # [ 5.640238] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 5.641388] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 5.642471] systemd[1]: Expecting device /dev/hvc0... worker # [ 5.643168] systemd[1]: Expecting device /dev/ttyS0... worker # [ 5.643921] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 5.644763] systemd[1]: Stopped target initrd-fs.target. worker # [ 5.645533] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 5.646321] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 5.647163] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 5.648047] systemd[1]: Reached target Path Units. worker # [ 5.648762] systemd[1]: Reached target Remote File Systems. worker # [ 5.649525] systemd[1]: Reached target Slice Units. worker # [ 5.650227] systemd[1]: Reached target Swaps. worker # [ 5.663029] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 5.664938] systemd[1]: Listening on Process Core Dump Socket. worker # [ 5.666246] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 5.667770] systemd[1]: Listening on Factory Reset Management. worker # [ 5.668648] systemd[1]: Listening on Hostname Service Socket. worker # [ 5.671239] systemd[1]: Starting Journal Log Access Socket... worker # [ 5.672418] systemd[1]: Listening on Journal Audit Socket. worker # [ 5.674871] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 5.675964] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 5.677056] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.678298] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 5.680781] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 5.681827] systemd[1]: Listening on udev Control Socket. worker # [ 5.682654] systemd[1]: Listening on udev Varlink Socket. worker # [ 5.685245] systemd[1]: Mounting Huge Pages File System... worker # [ 5.689803] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 5.696791] systemd[1]: Mounting Kernel Debug File System... worker # [ 5.704741] systemd[1]: Mounting Kernel Trace File System... worker # [ 5.713865] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 5.731028] systemd[1]: Starting Load Kernel Module configfs... worker # [ 5.739053] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 5.742247] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 5.745805] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 5.751800] systemd[1]: Mounting FUSE Control File System... worker # [ 5.752617] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 5.764904] systemd[1]: Starting Journal Service... worker # [ 5.770795] systemd[1]: Starting Load Kernel Modules... worker # [ 5.777794] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 5.781829] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 5.783783] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.788801] systemd[1]: Starting Coldplug All udev Devices... worker # [ 5.794992] systemd[1]: Listening on Journal Log Access Socket. worker # [ 5.796878] systemd[1]: Mounted Huge Pages File System. worker # [ 5.798779] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 5.800304] systemd[1]: Mounted Kernel Debug File System. worker # [ 5.801912] systemd[1]: Mounted Kernel Trace File System. worker # [ 5.807838] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 5.810061] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 5.812849] systemd[1]: Finished Load Kernel Module configfs. worker # [ 5.815022] systemd[1]: Mounted FUSE Control File System. worker # [ 5.821815] systemd[1]: Mounting Kernel Configuration File System... worker # [ 5.830802] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 5.841905] systemd[1]: Mounted Kernel Configuration File System. worker # [ 5.865777] EXT4-fs (vda): re-mounted 4b2b9d6f-0324-4dfe-b511-2b92b03049d5. worker # [ 5.873668] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 5.875057] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 5.877607] systemd-journald[288]: Collecting audit messages is enabled. worker # [ 5.878745] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 5.886022] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 5.886866] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 5.901811] loop: module loaded worker # [ 5.904367] systemd[1]: Finished Load Kernel Modules. worker # [ 5.910214] systemd[1]: Starting Firewall... worker # [ 5.915810] systemd[1]: Starting Apply Kernel Variables... hub # [ 15.074496] dhcpcd[715]: eth0: soliciting a DHCP lease worker # [ 5.955612] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 5.965846] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 15.229375] NET: Registered PF_PACKET protocol family worker # [ 5.823861] systemd[1]: Queued start job for default target Multi-User System.[ 5.968918] systemd[1]: Started Journal Service. hub # [ 15.089534] dhcpcd[715]: eth0: offered 10.0.2.15 from 10.0.2.2 hub # [ 15.091240] dhcpcd[715]: eth0: probing address 10.0.2.15/24 worker # worker # [ 5.829551] systemd[1]: Unnecessary job was removed for /dev/vdb. worker # [ 5.833510] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 5.845207] systemd-modules-load[289]: Inserted module 'loop' worker # [ 5.846585] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 5.880444] systemd[1]: Finished Apply Kernel Variables. worker # [ 6.045105] systemd-journald[288]: Received client request to flush runtime journal. hub # [ 15.444429] dhcpcd[715]: eth0: soliciting an IPv6 router hub # [ 15.446299] dhcpcd[715]: eth0: Router Advertisement from fe80::2 hub # [ 15.447952] dhcpcd[715]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 15.449226] dhcpcd[715]: eth0: adding route to fec0::/64 hub # [ 15.450244] dhcpcd[715]: eth0: adding default route via fe80::2 hub # [ 15.452460] tailscaled[648]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 15.453948] tailscaled[648]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 15.508408] tailscaled[648]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: DefaultRoute: ""->"eth0"; ips eth0: [fe80::5054:ff:fe12:3456/64]->[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] rebind-reason=[default-if-changed] hub # [ 15.515675] tailscaled[648]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 15.517793] tailscaled[648]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 15.519270] tailscaled[648]: dns: OScfg: {} hub # [ 15.546100] tailscaled[648]: wgengine: set DNS config again after major link change hub # [ 15.548190] tailscaled[648]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] hub # [ 15.550236] tailscaled[648]: magicsock: 0 active derp conns hub # [ 15.552306] tailscaled[648]: router: portUpdate(port=41641, network=udp6) hub # [ 15.553850] tailscaled[648]: router: portUpdate(port=41641, network=udp4) worker # [ 6.872247] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 6.916058] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 6.807690] systemd-oomd[290]: No swap; memory pressure usage will be degraded worker # [ 6.810792] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 6.817854] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 6.822299] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 6.825093] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 6.830865] systemd-udevd[320]: Using default interface naming scheme 'v261'. worker # [ 6.832721] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 6.834109] systemd[1]: Finished Coldplug All udev Devices. worker # [ 6.835072] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.837216] systemd[1]: Finished Firewall. worker # [ 6.839184] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 6.841160] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 6.843359] (udev-worker)[369]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 6.846715] (udev-worker)[369]: Network interface NamePolicy= disabled on kernel command line. worker # [ 6.848323] (udev-worker)[361]: Network interface NamePolicy= disabled on kernel command line. worker # [ 6.851282] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 6.855155] systemd[1]: Reached target First Boot Complete. worker # [ 6.855981] systemd[1]: Mounting /run/wrappers... worker # [ 6.856669] systemd[1]: Mounted /run/wrappers. worker # [ 6.857315] systemd[1]: Reached target Local File Systems. worker # [ 6.863155] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 6.864160] systemd[1]: Starting register-nix-paths.service... worker # [ 6.865245] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 6.866148] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 6.867417] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 6.869134] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 6.871150] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.872591] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 6.875177] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.878172] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 6.879729] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.882743] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.884076] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 6.886122] systemd[1]: Finished Flush Journal to Persistent Storage. worker # [ 6.887085] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 6.888133] systemd[1]: Starting Create System Files and Directories... worker # [ 6.891129] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 6.895601] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 6.934090] systemd[1]: Finished Create System Files and Directories. worker # [ 6.938983] systemd[1]: Starting Rebuild Journal Catalog... worker # [ 6.941224] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 6.992749] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 7.030361] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.035070] systemd[1]: Starting Update is Completed... worker # [ 7.099080] systemd[1]: Finished Update is Completed. worker # [ 6.965319] ACPI: button: Power Button [PWRF] worker # [ 7.126556] mousedev: PS/2 mouse device common for all mice worker # [ 7.163324] rtc_cmos PNP0B00:00: RTC can wake from S4 worker # [ 7.192270] rtc_cmos PNP0B00:00: registered as rtc0 worker # [ 7.192340] rtc_cmos PNP0B00:00: setting system clock to 2026-10-25T16:57:41 UTC (1792947461) worker # [ 7.192429] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 7.193063] systemd-journald[288]: Time jumped backwards, rotating. worker # [ 7.222888] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:07.0/virtio5/input/input4 worker # [ 7.232148] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 7.237522] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 7.237606] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 7.292484] Console: switching to colour dummy device 80x25 worker # [ 7.355016] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 7.355132] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 7.385648] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 7.385650] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 7.251096] systemd[1]: Finished register-nix-paths.service. worker # [ 7.252890] systemd[1]: Reached target System Initialization. worker # [ 7.253729] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 7.255375] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 7.257501] systemd[1]: Reached target Timer Units. worker # [ 7.258343] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 7.259786] systemd[1]: Listening on Nix Daemon Socket. worker # [ 7.261117] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 7.262297] systemd[1]: Listening on tribuchet build agent 1 socket. worker # [ 7.263212] systemd[1]: Reached target Socket Units. worker # [ 7.264207] systemd[1]: Reached target Basic System. worker # [ 7.430368] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 7.432366] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 7.292192] systemd[1]: Started backdoor.service. worker # [ 7.298064] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 7.301385] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 7.451929] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 7.452650] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 7.309635] systemd[1]: Starting Post-Boot Actions... worker # [ 7.314704] systemd[1]: Started Reset console on configuration changes. worker # [ 7.318857] systemd[1]: Starting resolvconf update... worker # [ 7.334895] systemd[1]: Starting D-Bus System Message Bus... worker # [ 7.344093] systemd[1]: Starting Virtual Console Setup... worker # [ 7.375419] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 7.377263] systemd[1]: Stopped Virtual Console Setup. worker # [ 7.389084] systemd[1]: Starting Virtual Console Setup... worker # [ 7.395694] systemd[1]: Finished Post-Boot Actions. worker # connecting to host... worker # [ 7.442288] nsncd[522]: Oct 25 16:57:41.891 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.444576] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.446620] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.450428] systemd[1]: Reached target User and Group Name Lookups. worker # [ 7.457452] systemd[1]: Starting User Login Management... worker # [ 7.458302] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 7.495673] dbus-broker-launch[526]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 7.498630] dbus-broker-launch[526]: NSS returned no entry for 'systemd-timesync' worker # [ 7.501140] dbus-broker-launch[526]: Invalid user-name in /nix/store/kvvpsp8i41789pfzqilws8l5y274sn48-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 7.510373] systemd[1]: Started D-Bus System Message Bus. worker # [ 7.547471] dbus-broker-launch[526]: Ready worker # [ 7.571610] systemd-vconsole-setup[530]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 7.573257] systemd[1]: Finished Virtual Console Setup. worker # [ 7.600042] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 7.600933] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 7.601893] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 7.606175] systemd[1]: Stopping User and Group Name Lookups... worker # [ 7.611184] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 7.613398] systemd[1]: nscd.service: Deactivated successfully. worker # [ 7.614291] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 7.615140] systemd[1]: nscd.service: Consumed 16ms CPU time over 304ms wall clock time, 7.1M memory peak, 5.8M read from disk. worker # [ 7.620186] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 7.628292] systemd-logind[549]: Watching system buttons on /dev/input/event2 (Power Button) worker # [ 7.631813] systemd-logind[549]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 7.635055] systemd-logind[549]: New seat seat0. worker # [ 7.641637] systemd[1]: Started User Login Management. worker # [ 7.644045] systemd[1]: Starting linger-users.service... worker # [ 7.791764] ppdev: user-space parallel port driver worker # [ 7.672656] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.673550] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.674404] systemd[1]: Reached target User and Group Name Lookups. worker # [ 7.677279] nsncd[598]: Oct 25 16:57:42.127 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.691414] systemd[1]: Finished resolvconf update. worker # [ 7.692323] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 7.693978] systemd[1]: Finished linger-users.service. worker # [ 7.697436] systemd[1]: Reached target Preparation for Network. worker # [ 7.701110] systemd-logind[549]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 7.702305] systemd[1]: Starting DHCP Client... worker # [ 7.706995] systemd[1]: Starting Address configuration of eth1... worker # [ 7.710123] systemd[1]: Starting Extra networking commands.... worker # [ 7.714259] systemd[1]: Starting Tailscale node agent... worker # [ 7.808181] network-addresses-eth1-start[627]: adding address 192.168.1.2/24... done worker # [ 7.824138] network-addresses-eth1-start[627]: adding address 2001:db8:1::2/64... done worker # [ 7.843397] systemd[1]: Finished Address configuration of eth1. hub # [ 17.140207] tailscaled[648]: monitor: RTM_NEWROUTE: src=, dst=fec0::6e15:a4ce:4274:72bd/128, gw=, outif=2, table=255 worker # [ 7.837065] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) worker # [ 7.849927] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 7.958771] dhcpcd[640]: dhcpcd-10.3.2 starting worker # [ 7.972289] dhcpcd[699]: dev: loaded udev worker # [ 7.973057] systemd[1]: Finished Extra networking commands.. worker # [ 7.973819] systemd[1]: Reached target Network. worker # [ 7.975614] systemd[1]: Starting Permit User Sessions... worker # [ 8.044252] Console: switching to colour frame buffer device 160x50 worker # [ 8.128018] 8021q: 802.1Q VLAN Support v1.8 worker # [ 8.000389] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 8.001438] systemd[1]: Stopped Virtual Console Setup. worker # [ 8.002213] systemd[1]: Stopping Virtual Console Setup... worker # [ 8.007341] systemd[1]: Starting Virtual Console Setup... hub # [ 17.268620] tailscaled[648]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 8.128035] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.178437] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 8.043892] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 8.080473] systemd[1]: Finished Permit User Sessions. worker # [ 8.090033] systemd[1]: Started Getty on tty1. worker # [ 8.090746] systemd[1]: Reached target Login Prompts. worker # [ 8.271416] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 8.278118] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.279860] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.281485] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.282299] cfg80211: failed to load regulatory.db worker # [ 8.153064] tailscaled[629]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 8.182155] systemd-vconsole-setup[704]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 8.183889] tailscaled[629]: Program starting: v1.102.5, Go 1.26.8: []string{"/nix/store/8isnvnbq4q8qh2303rq8mvxsphx4akzn-tailscale-1.102.5/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} worker # [ 8.187214] systemd[1]: Finished Virtual Console Setup. worker # [ 8.189589] tailscaled[629]: LogID: f6552c9b1fc9094f6f03172d5134e0e39c5ff83327dd711e5f3d3b9dc046f7d7 worker # [ 8.190879] tailscaled[629]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.193370] tailscaled[629]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 8.195111] tailscaled[629]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 8.202892] tailscaled[629]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:51247->[::1]:53: read: connection refused (in 9ms), trying bootstrap... worker # [ 8.210262] tailscaled[629]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ... worker # [ 8.211570] tailscaled[629]: bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 178.62.44.132:443: connect: network is unreachable worker # [ 8.215099] tailscaled[629]: trying bootstrapDNS("derp11.tailscale.com", "2600:1f1e:ee4:5611:ec5c:1736:d43b:a454") for "log.tailscale.com" ... worker # [ 8.217065] 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 unreachable worker # [ 8.219982] tailscaled[629]: trying bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" ... worker # [ 8.221359] tailscaled[629]: bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" error: Get "https://derp2f.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 208.111.34.178:443: connect: network is unreachable worker # [ 8.223882] tailscaled[629]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... worker # [ 8.230087] tailscaled[629]: bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7a0:e001]:443: connect: network is unreachable worker # [ 8.232683] tailscaled[629]: trying bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" ... worker # [ 8.234026] tailscaled[629]: bootstrapDNS("derp2d.tailscale.com", "192.73.252.65") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 192.73.252.65:443: connect: network is unreachable worker # [ 8.236623] tailscaled[629]: trying bootstrapDNS("derp2f.tailscale.com", "2607:f740:0:3f::f4") for "log.tailscale.com" ... worker # [ 8.237951] 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 unreachable worker # [ 8.385610] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.242654] tailscaled[629]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... worker # [ 8.243963] 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 unreachable worker # [ 8.246428] tailscaled[629]: trying bootstrapDNS("derp9c.tailscale.com", "2001:19f0:6401:fe7:5400:3ff:fe8d:6d9c") for "log.tailscale.com" ... worker # [ 8.248000] tailscaled[629]: 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 unreachable worker # [ 8.250900] tailscaled[629]: trying bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" ... worker # [ 8.252832] tailscaled[629]: bootstrapDNS("derp8d.tailscale.com", "178.62.44.132") for "log.tailscale.com" error: Get "https://derp8d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 178.62.44.132:443: connect: network is unreachable worker # [ 8.255390] tailscaled[629]: trying bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" ... worker # [ 8.256921] tailscaled[629]: bootstrapDNS("derp7.tailscale.com", "2401:c080:1000:467f:5400:2ff:feee:22aa") for "log.tailscale.com" error: Get "https://derp7.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2401:c080:1000:467f:5400:2ff:feee:22aa]:443: connect: network is unreachable worker # [ 8.259941] tailscaled[629]: trying bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" ... worker # [ 8.261230] tailscaled[629]: bootstrapDNS("derp8c.tailscale.com", "206.189.16.32") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 206.189.16.32:443: connect: network is unreachable worker # [ 8.266557] tailscaled[629]: trying bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" ... worker # [ 8.268146] tailscaled[629]: bootstrapDNS("derp9b.tailscale.com", "2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b") for "log.tailscale.com" error: Get "https://derp9b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:6401:eb5:5400:3ff:fe8d:6d9b]:443: connect: network is unreachable worker # [ 8.271081] tailscaled[629]: logtail: upload: log upload of 278 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/0883d89e963c421c003da75c9a497d1952cc21e61a906e5bfb972a8d459f856e": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 8.275851] dhcpcd[699]: eth0: waiting for carrier worker # [ 8.276645] dhcpcd[699]: eth0: carrier acquired worker # [ 8.279082] dbus-broker-launch[526]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 8.287757] dhcpcd[699]: DUID 00:01:00:01:32:70:f1:86:52:54:00:12:34:56 worker # [ 8.288634] dhcpcd[699]: eth0: IAID 00:12:34:56 worker # [ 8.289516] dhcpcd[699]: eth0: adding address fe80::5054:ff:fe12:3456 worker # [ 8.299096] tailscaled[629]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.300305] tailscaled[629]: dns: using "openresolv" mode worker # [ 8.301128] tailscaled[629]: dns: using dns.openresolvManager worker # [ 8.547913] kvm_amd: TSC scaling supported worker # [ 8.548325] kvm_amd: Nested Virtualization enabled worker # [ 8.405736] tailscaled[629]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found worker # [ 8.552272] kvm_amd: Nested Paging enabled worker # [ 8.553190] kvm_amd: LBR virtualization supported worker # [ 8.553668] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 8.413315] tailscaled[629]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 8.414340] systemd[1]: Started Tailscale node agent. worker # [ 8.559018] kvm_amd: Virtual GIF supported worker # [ 8.559487] kvm_amd: Virtual NMI enabled worker # [ 8.563180] tun: Universal TUN/TAP device driver, 1.6 worker # [ 8.429144] (udev-worker)[360]: Network interface NamePolicy= disabled on kernel command line. worker # [ 8.451066] tailscaled[629]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.452184] tailscaled[629]: dns: using "openresolv" mode worker # [ 8.458366] tailscaled[629]: dns: using dns.openresolvManager worker # [ 8.459268] tailscaled[629]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 8.464146] tailscaled[629]: magicsock: disco key = d:c8fe18927b49763f worker # [ 8.465528] tailscaled[629]: Creating WireGuard device... worker # [ 8.467325] tailscaled[629]: Bringing WireGuard device up... worker # [ 8.468124] tailscaled[629]: Bringing router up... worker # [ 8.468752] tailscaled[629]: router: using firewall mode pref worker # [ 8.472472] tailscaled[629]: router: portUpdate(port=41641, network=udp6) worker # [ 8.481801] tailscaled[629]: external route: up worker # [ 8.492076] tailscaled[629]: router: default choosing iptables worker # [ 8.637348] EDAC MC: Ver: 3.0.0 worker # [ 8.503677] tailscaled[629]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 8.506050] tailscaled[629]: Clearing router settings... worker # [ 8.506969] tailscaled[629]: Starting network monitor... worker # [ 8.507811] tailscaled[629]: Engine created. worker # [ 8.515549] tailscaled[629]: router: portUpdate(port=41641, network=udp4) worker # [ 8.523354] tailscaled[629]: pm: migrating "_daemon" profile to new format worker # [ 8.524288] tailscaled[629]: envknob: PORT="41641" worker # [ 8.524992] tailscaled[629]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.525989] tailscaled[629]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 8.527113] tailscaled[629]: got LocalBackend in 111ms worker # [ 8.527808] tailscaled[629]: Start worker # [ 8.528318] tailscaled[629]: ipnext: "conn25": skipping extension worker # [ 8.529183] tailscaled[629]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop worker # [ 8.531813] tailscaled[629]: profile data directory: profile not found worker # [ 8.532928] tailscaled[629]: Backend: logs: be:f6552c9b1fc9094f6f03172d5134e0e39c5ff83327dd711e5f3d3b9dc046f7d7 fe: worker # [ 8.534298] tailscaled[629]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 8.536095] tailscaled[629]: blockEngineUpdates(true) worker # [ 8.537045] tailscaled[629]: wgengine: Reconfig: configuring router worker # [ 8.537992] tailscaled[629]: wgengine: Reconfig: user dialer worker # [ 8.538862] tailscaled[629]: wgengine: Reconfig: configuring DNS worker # [ 8.539866] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 8.541030] tailscaled[629]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 8.542020] tailscaled[629]: dns: OScfg: {} worker # [ 8.543051] tailscaled[629]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 8.728443] dhcpcd[699]: eth0: soliciting a DHCP lease worker # [ 8.879486] NET: Registered PF_PACKET protocol family worker # [ 8.739429] dhcpcd[699]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 8.742161] dhcpcd[699]: eth0: probing address 10.0.2.15/24 worker # [ 9.673970] dhcpcd[699]: eth0: soliciting an IPv6 router worker # [ 9.676662] dhcpcd[699]: eth0: Router Advertisement from fe80::2 worker # [ 9.679235] dhcpcd[699]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 9.682463] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 9.685526] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 9.688163] dhcpcd[699]: eth0: adding route to fec0::/64 worker # [ 9.691209] dhcpcd[699]: eth0: adding default route via fe80::2 worker # [ 10.524146] 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::cb6d:69ae:2b4f:9787/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::cb6d:69ae:2b4f:9787/64] rebind-reason=[default-if-changed] worker # [ 10.537228] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 10.540362] tailscaled[629]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 10.542713] tailscaled[629]: dns: OScfg: {} worker # [ 10.570680] tailscaled[629]: wgengine: set DNS config again after major link change worker # [ 10.573683] tailscaled[629]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::cb6d:69ae:2b4f:9787/64] worker # [ 10.576825] tailscaled[629]: magicsock: 0 active derp conns worker # [ 10.580121] tailscaled[629]: router: portUpdate(port=41641, network=udp6) worker # [ 10.582295] tailscaled[629]: router: portUpdate(port=41641, network=udp4) worker # [ 10.799416] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=fec0::cb6d:69ae:2b4f:9787/128, gw=, outif=2, table=255 hub # [ 20.292322] dhcpcd[715]: eth0: leased 10.0.2.15 for 86400 seconds hub # [ 20.293241] dhcpcd[715]: eth0: adding route to 10.0.2.0/24 hub # [ 20.293932] dhcpcd[715]: eth0: adding default route via 10.0.2.2 hub # [ 20.296365] tailscaled[648]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 20.298150] tailscaled[648]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 20.299798] tailscaled[648]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 20.300996] tailscaled[648]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 hub # [ 20.303855] tailscaled[648]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} new: interfaces.State{defaultRoute=eth0 ifs={eth0:[10.0.2.15/24 llu6 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} diff: ips eth0: [fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] rebind-reason=[ips-changed] hub # [ 20.316118] tailscaled[648]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 20.318450] tailscaled[648]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 20.319488] tailscaled[648]: dns: OScfg: {} hub # [ 20.383405] systemd[1]: Started DHCP Client. hub # [ 20.386067] systemd[1]: Reached target Network is Online. hub # [ 20.389836] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 20.391451] systemd[1]: Reached target Multi-User System. hub # [ 20.392647] systemd[1]: Startup finished in 884ms (kernel) + 7.625s (initrd) + 11.882s (userspace) = 20.392s. hub # [ 20.625657] headscale-start[927]: 2026-10-25T16:57:46Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 20.627932] headscale-start[927]: 2026-10-25T16:57:46Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 20.674570] headscale-start[927]: 2026-10-25T16:57:46Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 20.678906] headscale-start[927]: 2026-10-25T16:57:46Z INF starting headscale commit=v0.29.4 version=0.29.4 hub # [ 20.680204] headscale-start[927]: 2026-10-25T16:57:46Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 20.682715] headscale-start[927]: 2026-10-25T16:57:46Z 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:[0x217497482120]} hub # [ 20.685665] headscale-start[927]: 2026-10-25T16:57:46Z INF github.com/juanfont/headscale/hscontrol/derp/server/derp_server.go:145 > derp nodes[0]: &{Name:999 RegionID:999 HostName:hub CertName: IPv4: IPv6: STUNPort:3478 STUNOnly:false DERPPort:443 InsecureForTests:false STUNTestIP: CanPort80:false} hub # [ 20.690551] headscale-start[927]: 2026-10-25T16:57:46Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 20.694287] headscale-start[927]: 2026-10-25T16:57:46Z INF stun server started at [::]:3478 hub # [ 20.698224] headscale-start[927]: 2026-10-25T16:57:46Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 20.699869] headscale-start[927]: 2026-10-25T16:57:46Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 20.701182] headscale-start[927]: 2026-10-25T16:57:46Z INF metrics server disabled (metrics_listen_addr is empty) worker # [ 11.695274] tailscaled[629]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 hub: (finished: waiting for unit headscale, in 12.51 seconds) hub: waiting for TCP port 443 on localhost hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 0.05 seconds) hub: waiting for unit tailscaled hub: (finished: waiting for unit tailscaled, in 0.02 seconds) worker: waiting for unit tailscaled worker: waiting for the VM to finish booting worker: Guest shell says: b'Spawning backdoor root shell...\n' worker: connected to guest root shell worker: (connecting took 0.00 seconds) worker: (finished: waiting for the VM to finish booting, in 0.00 seconds) worker: (finished: waiting for unit tailscaled, in 0.04 seconds) hub: must succeed: headscale users create test hub # [ 21.362969] tailscaled[648]: wgengine: set DNS config again after major link change hub # [ 21.367493] tailscaled[648]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::6e15:a4ce:4274:72bd/64] hub # [ 21.371871] tailscaled[648]: magicsock: 0 active derp conns hub # [ 21.377372] tailscaled[648]: router: portUpdate(port=41641, network=udp6) hub # [ 21.380114] tailscaled[648]: router: portUpdate(port=41641, network=udp4) hub # [ 21.382686] tailscaled[648]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 21.385704] tailscaled[648]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 hub # [ 21.696698] headscale-start[927]: 2026-10-25T16:57:47Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 0.54 seconds) hub: must succeed: headscale preauthkeys -u 1 create --reusable hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.11 seconds) hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-02NRqmIFHcrR-mzK557f3cyob2nRtlZvfLfwJx0YIJLblmbHGn9okKZDUuezrMhnkfdoDaPi75WOB --hostname hub hub # [ 21.852175] tailscaled[648]: localapi: [POST] /localapi/v0/check-prefs hub # [ 21.853697] tailscaled[648]: localapi: [POST] /localapi/v0/start hub # [ 21.854993] tailscaled[648]: control: client.Shutdown ... hub # [ 21.855920] tailscaled[648]: control: updateRoutine: exiting hub # [ 21.856904] tailscaled[648]: control: authRoutine: exiting hub # [ 21.857952] tailscaled[648]: control: mapRoutine: exiting hub # [ 21.858864] tailscaled[648]: control: Client.Shutdown done. hub # [ 21.859739] tailscaled[648]: Start hub # [ 21.861044] tailscaled[648]: Start: updated prefs: Prefs{ra=false dns=true want=true routes=[] statefulFiltering=false nf=on url="https://hub" host="hub" update=check Persist=nil}, reason: [opts.UpdatePrefs] hub # [ 21.863346] tailscaled[648]: generating new machine key hub # [ 21.902100] tailscaled[648]: machine key written to store hub # [ 21.902943] tailscaled[648]: profile data directory: profile not found hub # [ 21.903836] tailscaled[648]: Backend: logs: be:ba4ca9504ec189ed89ae2557b84329deed2aba443a85de12bc841675ba556af4 fe: hub # [ 21.906299] tailscaled[648]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 21.907974] tailscaled[648]: blockEngineUpdates(true) hub # [ 21.908651] tailscaled[648]: Reconfig(down): no changes made to Engine config hub # [ 21.910470] tailscaled[648]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 21.911720] tailscaled[648]: health(warnable=wantrunning-false): ok hub # [ 21.913458] tailscaled[648]: localapi: [POST] /localapi/v0/login-interactive hub # [ 21.914449] tailscaled[648]: StartLoginInteractiveAs("root"): url=false hub # [ 21.915357] tailscaled[648]: control: client.Login(2) hub # [ 21.915996] tailscaled[648]: control: LoginInteractive -> regen=true hub # [ 21.916883] tailscaled[648]: control: doLogin(regen=true, hasUrl=false) hub # [ 21.957949] tailscaled[648]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 21.963525] headscale-start[927]: 2026-10-25T16:57:47Z INF http request bytes=176 elapsed=0.332444 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:34010 status=200 hub # [ 21.966608] tailscaled[648]: control: control server key from https://hub: ts2021=[qONZ8], legacy= hub # [ 21.969052] tailscaled[648]: control: Generating a new nodekey. hub # [ 21.970432] tailscaled[648]: control: RegisterReq: onode= node=[bh+66] fup=false nks=false hub # [ 22.697662] headscale-start[927]: 2026-10-25T16:57:48Z INF http request bytes=249 elapsed=718.519533 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:34024 status=200 hub # [ 22.701551] tailscaled[648]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 22.703585] tailscaled[648]: blockEngineUpdates(false) hub # [ 23.199088] headscale-start[927]: 2026-10-25T16:57:49Z INF http request bytes=0 elapsed=497.521612 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34024 status=200 worker # [ 14.038881] dhcpcd[699]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 14.041583] dhcpcd[699]: eth0: adding route to 10.0.2.0/24 worker # [ 14.043466] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 14.045936] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 14.047517] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 14.049209] tailscaled[629]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 14.050666] dhcpcd[699]: eth0: adding default route via 10.0.2.2 worker # [ 14.051664] tailscaled[629]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::cb6d:69ae:2b4f:9787/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::cb6d:69ae:2b4f:9787/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::cb6d:69ae:2b4f:9787/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::cb6d:69ae:2b4f:9787/64] rebind-reason=[ips-changed] worker # [ 14.063188] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 14.065556] tailscaled[629]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 14.066673] tailscaled[629]: dns: OScfg: {} worker # [ 14.087376] dhcpcd[785]: /nix/store/w7zqzbb79qk7yw3hy90mipdjani74ypc-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (782) - Operation not permitted worker # [ 14.089746] dhcpcd[785]: .resolvconf-wrapped: clearing stale lock pid 782 worker # [ 14.096278] tailscaled[629]: wgengine: set DNS config again after major link change worker # [ 14.098585] tailscaled[629]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::cb6d:69ae:2b4f:9787/64] worker # [ 14.102136] tailscaled[629]: magicsock: 0 active derp conns worker # [ 14.104373] tailscaled[629]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 14.107380] tailscaled[629]: router: portUpdate(port=41641, network=udp6) worker # [ 14.110217] tailscaled[629]: router: portUpdate(port=41641, network=udp4) worker # [ 14.111095] tailscaled[629]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") worker # [ 14.148400] systemd[1]: Started DHCP Client. worker # [ 14.150168] systemd[1]: Reached target Multi-User System. worker # [ 14.151252] systemd[1]: Startup finished in 896ms (kernel) + 3.762s (initrd) + 9.492s (userspace) = 14.150s. hub # [ 23.699645] headscale-start[927]: 2026-10-25T16:57:49Z INF node connected machine.key=[erNif] node.expired=false node.id=1 node.is_tagged=false node.key=[bh+66] node.name=hub node.online=true user.name=test hub # [ 23.709404] headscale-start[927]: 2026-10-25T16:57:49Z INF github.com/juanfont/headscale/hscontrol/poll.go:272 > node has connected chan=0x2174973bab60 component=poll machine.key=[erNif] node.expired=false node.id=1 node.is_tagged=false node.key=[bh+66] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 24.941657] tailscaled[648]: magicsock: new contact: control-netmap usec=11512117 cached=false hub # [ 24.945391] tailscaled[648]: active login: test hub # [ 25.192257] tailscaled[648]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 25.195518] tailscaled[648]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 25.202365] tailscaled[648]: magicsock: SetPrivateKey called (init) hub # [ 25.208209] tailscaled[648]: wgengine: Reconfig: configuring router hub # [ 25.213134] tailscaled[648]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [0ms] (forced=false) hub # [ 25.216774] tailscaled[648]: magicsock: home is now derp-999 () hub # [ 25.220294] tailscaled[648]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 25.224108] tailscaled[648]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 25.228424] tailscaled[648]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 25.237151] tailscaled[648]: magicsock: endpoints changed: 127.0.0.1:41641 (stun), [2001:db8:1::1]:41641 (stun), 10.0.2.15:41641 (local), 192.168.1.1:41641 (local), [fec0::5054:ff:fe12:3456]:41641 (local), [fec0::6e15:a4ce:4274:72bd]:41641 (local) hub # [ 25.249126] tailscaled[648]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 25.260960] tailscaled[648]: magicsock: derp-999 connected; connGen=1 hub # [ 25.423651] tailscaled[648]: router: enabling connmark-based rp_filter workaround hub # [ 25.458856] tailscaled[648]: wgengine: Reconfig: user dialer hub # [ 25.459727] tailscaled[648]: tsdial: bart table size: 2 hub # [ 25.460469] tailscaled[648]: wgengine: Reconfig: configuring DNS hub # [ 25.461320] tailscaled[648]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} hub # [ 25.482527] tailscaled[648]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} hub # [ 25.483886] tailscaled[648]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 25.531853] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 25.533171] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 25.534435] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 25.535520] systemd[1]: Stopping User and Group Name Lookups... hub # [ 25.536402] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 25.538101] systemd[1]: nscd.service: Deactivated successfully. hub # [ 25.539330] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 25.550716] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 25.569644] tailscaled[648]: peerapi: serving on http://100.64.0.1:58436 hub # [ 25.571272] tailscaled[648]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 25.573534] tailscaled[648]: updating netmap in disk cache hub # [ 25.578022] tailscaled[648]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 25.580456] tailscaled[648]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 25.583637] tailscaled[648]: health(warnable=warming-up): ok hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-02NRqmIFHcrR-mzK557f3cyob2nRtlZvfLfwJx0YIJLblmbHGn9okKZDUuezrMhnkfdoDaPi75WOB --hostname hub, in 3.77 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-02NRqmIFHcrR-mzK557f3cyob2nRtlZvfLfwJx0YIJLblmbHGn9okKZDUuezrMhnkfdoDaPi75WOB --hostname tt-worker hub # [ 25.592682] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 25.593897] nsncd[1082]: Oct 25 16:57:51.472 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 25.596536] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 25.598100] systemd[1]: Reached target User and Group Name Lookups. worker # [ 16.373662] tailscaled[629]: localapi: [POST] /localapi/v0/check-prefs worker # [ 16.377274] tailscaled[629]: localapi: [POST] /localapi/v0/start worker # [ 16.378824] tailscaled[629]: control: client.Shutdown ... worker # [ 16.380201] tailscaled[629]: control: mapRoutine: exiting worker # [ 16.381719] tailscaled[629]: control: authRoutine: exiting worker # [ 16.383943] tailscaled[629]: control: updateRoutine: exiting worker # [ 16.385905] tailscaled[629]: control: Client.Shutdown done. worker # [ 16.388606] tailscaled[629]: Start worker # [ 16.390474] 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] worker # [ 16.395536] tailscaled[629]: generating new machine key worker # [ 16.437146] tailscaled[629]: machine key written to store worker # [ 16.439610] tailscaled[629]: profile data directory: profile not found hub # [ 25.703755] headscale-start[927]: 2026-10-25T16:57:51Z INF http request bytes=0 elapsed=125.82493 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34024 status=200 worker # [ 16.442631] tailscaled[629]: Backend: logs: be:f6552c9b1fc9094f6f03172d5134e0e39c5ff83327dd711e5f3d3b9dc046f7d7 fe: worker # [ 16.449524] tailscaled[629]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 16.452961] tailscaled[629]: blockEngineUpdates(true) worker # [ 16.455102] tailscaled[629]: Reconfig(down): no changes made to Engine config worker # [ 16.460125] tailscaled[629]: localapi: [POST] /localapi/v0/login-interactive worker # [ 16.462420] tailscaled[629]: StartLoginInteractiveAs("root"): url=false worker # [ 16.464468] tailscaled[629]: control: client.Login(2) worker # [ 16.468102] tailscaled[629]: control: LoginInteractive -> regen=true worker # [ 16.470204] tailscaled[629]: control: doLogin(regen=true, hasUrl=false) worker # [ 16.473108] tailscaled[629]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 16.475294] tailscaled[629]: health(warnable=wantrunning-false): ok worker # [ 16.508955] tailscaled[629]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 25.777393] headscale-start[927]: 2026-10-25T16:57:51Z INF http request bytes=176 elapsed=0.501461 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:53582 status=200 worker # [ 16.521061] tailscaled[629]: control: control server key from https://hub: ts2021=[qONZ8], legacy= worker # [ 16.522209] tailscaled[629]: control: Generating a new nodekey. worker # [ 16.523362] tailscaled[629]: control: RegisterReq: onode= node=[qV5La] fup=false nks=false hub # [ 26.204641] headscale-start[927]: 2026-10-25T16:57:52Z INF http request bytes=0 elapsed=492.600317 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:34024 status=200 hub # [ 26.706305] headscale-start[927]: 2026-10-25T16:57:52Z INF http request bytes=249 elapsed=908.975861 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:53594 status=200 worker # [ 17.449892] tailscaled[629]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 17.458356] tailscaled[629]: blockEngineUpdates(false) hub # [ 27.087900] tailscaled[648]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 27.205977] headscale-start[927]: 2026-10-25T16:57:53Z INF http request bytes=0 elapsed=477.999857 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:53594 status=200 hub # [ 27.707793] headscale-start[927]: 2026-10-25T16:57:53Z INF node connected machine.key=[8XtSv] node.expired=false node.id=2 node.is_tagged=false node.key=[qV5La] node.name=tt-worker node.online=true user.name=test hub # [ 27.713669] headscale-start[927]: 2026-10-25T16:57:53Z INF github.com/juanfont/headscale/hscontrol/poll.go:272 > node has connected chan=0x217497387e30 component=poll machine.key=[8XtSv] node.expired=false node.id=2 node.is_tagged=false node.key=[qV5La] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test hub # [ 27.889353] tailscaled[648]: wgengine: Reconfig: configuring router hub # [ 27.892534] tailscaled[648]: wgengine: Reconfig: user dialer hub # [ 27.895201] tailscaled[648]: tsdial: bart table size: 4 hub # [ 27.896968] tailscaled[648]: wgengine: Reconfig: configuring DNS hub # [ 27.898967] tailscaled[648]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} hub # [ 27.938817] tailscaled[648]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} hub # [ 27.940110] tailscaled[648]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 19.965969] tailscaled[629]: magicsock: new contact: control-netmap usec=11503961 cached=false worker # [ 19.970444] tailscaled[629]: active login: test worker # [ 20.086179] tailscaled[629]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 20.089348] tailscaled[629]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 20.093237] tailscaled[629]: magicsock: SetPrivateKey called (init) worker # [ 20.096245] tailscaled[629]: wgengine: Reconfig: configuring router worker # [ 20.210281] tailscaled[629]: router: enabling connmark-based rp_filter workaround worker # [ 20.226128] tailscaled[629]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [0ms] (forced=false) worker # [ 20.227404] tailscaled[629]: magicsock: home is now derp-999 () worker # [ 20.228200] 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::cb6d:69ae:2b4f:9787]:41641 (local) worker # [ 20.230388] tailscaled[629]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 20.231413] tailscaled[629]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 20.232748] tailscaled[629]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 20.238078] tailscaled[629]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 20.243670] tailscaled[629]: magicsock: derp-999 connected; connGen=1 worker # [ 20.245557] tailscaled[629]: wgengine: Reconfig: user dialer worker # [ 20.246306] tailscaled[629]: tsdial: bart table size: 4 worker # [ 20.246989] tailscaled[629]: wgengine: Reconfig: configuring DNS worker # [ 20.248054] tailscaled[629]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} worker # [ 20.262910] tailscaled[629]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} worker # [ 20.264151] tailscaled[629]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 20.304984] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 20.305934] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 20.308060] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 20.308909] systemd[1]: Stopping User and Group Name Lookups... worker # [ 20.311124] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 20.312110] systemd[1]: nscd.service: Deactivated successfully. worker # [ 20.314136] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 20.323672] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 20.331730] tailscaled[629]: peerapi: serving on http://100.64.0.2:46590 worker # [ 20.334258] tailscaled[629]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 20.335277] tailscaled[629]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 20.341056] tailscaled[629]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 20.343317] tailscaled[629]: updating netmap in disk cache worker # [ 20.345890] tailscaled[629]: health(warnable=warming-up): ok worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-02NRqmIFHcrR-mzK557f3cyob2nRtlZvfLfwJx0YIJLblmbHGn9okKZDUuezrMhnkfdoDaPi75WOB --hostname tt-worker, in 4.02 seconds) ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker: waiting for success: tailscale ping hub ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker # [ 20.359057] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 20.361402] nsncd[965]: Oct 25 16:57:54.810 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 20.363205] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 20.364063] systemd[1]: Reached target User and Group Name Lookups. worker # [ 20.380177] tailscaled[629]: localapi: [POST] /localapi/v0/ping worker # [ 20.381141] tailscaled[629]: ping(100.64.0.1): sending disco ping to [bh+66] hub ... worker # [ 20.383761] tailscaled[629]: magicsock: disco: node [bh+66] d:9df9d40a0cbd055d now using 192.168.1.1:41641 mtu=1360 tx=dbd72d1b7348 worker # [ 20.385282] tailscaled[629]: magicsock: new contact: peer=[bh+66] usec=11922352 cached=false via=direct worker: (finished: waiting for success: tailscale ping hub, in 0.03 seconds) hub: must succeed: tailscale ip -4 hub: (finished: must succeed: tailscale ip -4, in 0.02 seconds) worker: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml worker: (finished: must succeed: cp --remove-destination $(readlink -f /etc/tribuchet/worker.toml) /etc/tribuchet/worker.toml && sed -i 's/HUB_TS_IP/100.64.0.1/' /etc/tribuchet/worker.toml, in 0.02 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 29.712483] headscale-start[927]: 2026-10-25T16:57:55Z INF http request bytes=0 elapsed=107.213906 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:53594 status=200 hub # [ 29.726239] systemd[1]: Starting tribuchet-hub.socket... hub # [ 29.728733] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 29.731747] systemd[1]: Starting tribuchet-hub.service... hub # [ 29.765144] tribuchet[1126]: 2026-10-25T16:57:55.644956Z INFO tribuchet::hub::serve: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 29.768292] tribuchet[1126]: 2026-10-25T16:57:55.648324Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 29.771030] tribuchet[1126]: 2026-10-25T16:57:55.651111Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 29.774279] systemd[1]: Started tribuchet-hub.service. hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.09 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 20.547298] systemd[1]: Starting tribuchet build worker... worker # [ 20.581554] tribuchet[998]: 2026-10-25T16:57:55.031350Z 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, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 20.589791] tribuchet[998]: 2026-10-25T16:57:55.031757Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 20.593152] systemd[1]: Started tribuchet build worker. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.08 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' worker # [ 20.598760] systemd[1]: Starting tribuchet build agent 1... worker # [ 20.632572] systemd[1]: Started tribuchet build agent 1. worker # [ 20.653931] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1006]: 2026-10-25T16:57:55.105043Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 20.657187] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1006]: 2026-10-25T16:57:55.108044Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 20.660228] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1006]: 2026-10-25T16:57:55.108078Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 20.662716] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1006]: 2026-10-25T16:57:55.108188Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 20.665863] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. hub # [ 29.935986] tailscaled[648]: magicsock: disco: node [qV5La] d:c8fe18927b49763f now using 192.168.1.2:41641 mtu=1360 tx=88ffa4b2f01e hub # [ 29.937997] tailscaled[648]: magicsock: new contact: peer=[qV5La] usec=16509325 cached=false via=direct hub # [ 29.945562] tribuchet[1126]: 2026-10-25T16:57:55.825650Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }] worker # [ 20.722838] tribuchet[998]: 2026-10-25T16:57:55.173619Z INFO tribuchet::worker::session: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] hub # [ 30.216232] headscale-start[927]: 2026-10-25T16:57:56Z INF http request bytes=0 elapsed=500.393206 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:53594 status=200 worker # [ 21.022840] tailscaled[629]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.05 seconds) subtest: a build dispatches over the tailnet hub: must succeed: echo tailscale-auth-payload > /root/payload hub: (finished: must succeed: echo tailscale-auth-payload > /root/payload, in 0.01 seconds) hub: must succeed: nix-store --add /root/payload hub: (finished: must succeed: nix-store --add /root/payload, in 0.22 seconds) hub: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/1mv3qz005gkbalxfghk4y3s8ayv4d2dl-bash-interactive-5.3p15"; unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload"; in derivation { name = "tt-tailscale"; system = "x86_64-linux"; builder = bash + "/bin/bash"; args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ]; } EOF hub: (finished: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/1mv3qz005gkbalxfghk4y3s8ayv4d2dl-bash-interactive-5.3p15"; unique = builtins.storePath "/nix/store/fi6cbk189k8l41ds2fp4z5vi1zsy6w8p-payload"; in derivation { name = "tt-tailscale"; system = "x86_64-linux"; builder = bash + "/bin/bash"; args = [ "-c" ("read l < " + unique + "; echo \"$l ok\" > $out") ]; } EOF, in 0.03 seconds) hub: must succeed: nix-build /root/test.nix --no-out-link hub # this derivation will be built: hub # /nix/store/hwpzpyi7s4fb06wngq5fzwyf301p5ppz-tt-tailscale.drv hub # building '/nix/store/hwpzpyi7s4fb06wngq5fzwyf301p5ppz-tt-tailscale.drv'... hub # [ 32.260563] tribuchet[1126]: 2026-10-25T16:57:58.140370Z INFO tribuchet::hub::submit: queueing build id="50a751e72d378e92636278962ea13727" system="x86_64-linux" hub # tribuchet: building on tt-worker hub # [ 32.264077] tribuchet[1126]: 2026-10-25T16:57:58.143061Z INFO tribuchet::hub: dispatching build id="50a751e72d378e92636278962ea13727" worker="tt-worker" worker # [ 23.002745] tribuchet[998]: 2026-10-25T16:57:57.452713Z INFO tribuchet::worker::session: build assigned id="50a751e72d378e92636278962ea13727" worker # [ 23.007851] systemd[1]: Started Nix Daemon. worker # [ 23.042799] nix-daemon[1011]: accepted connection from pid 998, user tribuchet (trusted) hub # [ 32.314049] tribuchet[1126]: 2026-10-25T16:57:58.193901Z INFO tribuchet::hub::relay::staging: input path negotiation done id="50a751e72d378e92636278962ea13727" total=8 missing=1 hub # [ 32.320973] systemd[1]: Started Nix Daemon. hub # [ 32.373698] nix-daemon[1164]: accepted connection from pid 1126, user root (trusted) worker # [ 23.131968] nix-daemon[1011]: accepted connection from pid 998, user tribuchet (trusted) hub # [ 32.651065] tailscaled[648]: magicsock: disco: node [qV5La] d:c8fe18927b49763f now using [2001:db8:1::2]:41641 mtu=1360 tx=301779e5dc20 worker # [ 23.792919] tribuchet[998]: 2026-10-25T16:57:58.242796Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="50a751e72d378e92636278962ea13727" fixed_output=false network=false net_isolation=false worker # [ 23.807168] systemd[1]: Starting tribuchet build agent 1... worker # [ 23.868552] systemd[1]: Started tribuchet build agent 1. worker # [ 23.889945] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1022]: 2026-10-25T16:57:58.341057Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 23.892637] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1022]: 2026-10-25T16:57:58.343960Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 23.894958] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1022]: 2026-10-25T16:57:58.346286Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 23.904437] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1022]: 2026-10-25T16:57:58.355752Z INFO tribuchet::worker::agent: builder started id="50a751e72d378e92636278962ea13727" pid=1028 worker # [ 23.908702] tribuchet[998]: 2026-10-25T16:57:58.359852Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="50a751e72d378e92636278962ea13727" pid=1028 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/ad713f1b31ad0afb/build worker # [ 24.391984] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1022]: 2026-10-25T16:57:58.842298Z INFO tribuchet::worker::agent: builder exited code=0 wall_ms=486 cpu_usec=5149 peak_memory_bytes=1003520 worker # [ 24.510523] tribuchet[998]: 2026-10-25T16:57:58.960805Z INFO tribuchet::worker::build::agent_exec: builder finished id="50a751e72d378e92636278962ea13727" exit_code=0 aborted=None worker # [ 24.540732] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1022]: 2026-10-25T16:57:58.991982Z INFO tribuchet::worker::agent: cleanup done id="50a751e72d378e92636278962ea13727" worker # [ 24.550593] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. worker # [ 24.563932] systemd[1]: Starting tribuchet build agent 1... worker # [ 24.601186] systemd[1]: Started tribuchet build agent 1. worker # [ 24.620914] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1044]: 2026-10-25T16:57:59.072029Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 24.623592] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1044]: 2026-10-25T16:57:59.074916Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 24.625872] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1044]: 2026-10-25T16:57:59.077199Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 24.627938] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1044]: 2026-10-25T16:57:59.079269Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 24.631339] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. worker # [ 24.719600] tribuchet[998]: 2026-10-25T16:57:59.169808Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="50a751e72d378e92636278962ea13727" hub # [ 33.991252] tribuchet[1126]: 2026-10-25T16:57:59.870138Z INFO tribuchet::hub::relay: build usage id="50a751e72d378e92636278962ea13727" key="5d366c6b1b506c341b523853155530bee8d7c4d3b0695b36c74b7b2b56157719" exit_code=0 wall_ms=486 cpu_usec=5149 peak_memory_bytes=1003520 oom_killed=false worker # [ 24.745418] tribuchet[998]: 2026-10-25T16:57:59.196662Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="50a751e72d378e92636278962ea13727" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 2.85 seconds) hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/x0yl2x49z17dd96jmikkdwb5fcgwjbpr-tt-tailscale hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/x0yl2x49z17dd96jmikkdwb5fcgwjbpr-tt-tailscale, in 0.02 seconds) hub: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build' hub: (finished: must succeed: journalctl -u tribuchet-hub | grep -q 'dispatching build', in 0.01 seconds) worker: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished' worker: (finished: must succeed: journalctl -u tribuchet-worker | grep -q 'builder finished', in 0.03 seconds) (finished: subtest: a build dispatches over the tailnet, in 3.19 seconds) subtest: a non-tailnet peer is rejected worker: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml worker: (finished: must succeed: sed -i 's|http://.*:7437|http://hub:7437|' /etc/tribuchet/worker.toml, in 0.01 seconds) worker: must succeed: systemctl restart tribuchet-worker worker # [ 24.869383] systemd[1]: Stopping tribuchet build worker... worker # [ 24.871159] tribuchet[998]: 2026-10-25T16:57:59.320573Z INFO tribuchet::worker: handover requested; exiting worker # [ 24.874416] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 24.876519] systemd[1]: Stopped tribuchet build worker. hub # [ 34.138443] tribuchet[1126]: 2026-10-25T16:58:00.018509Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 24.877389] systemd[1]: tribuchet-worker.service: Consumed 29ms CPU time over 4.329s wall clock time, 2.4M memory peak, 4K written to disk, 3.1K incoming IP traffic, 2.2K outgoing IP traffic. worker # [ 24.883470] systemd[1]: Starting tribuchet build worker... worker # [ 24.903605] tribuchet[1061]: 2026-10-25T16:57:59.354705Z 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, sandbox: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 24.911290] tribuchet[1061]: 2026-10-25T16:57:59.362610Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/r6zw8gd10c7qv9sifzg4r7h1s5qmrxjp-busybox-1.37.0/bin/busybox") worker # [ 25.435644] systemd[1]: Started tribuchet build worker. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.59 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' worker # [ 25.447573] systemd[1]: Starting tribuchet build agent 1... worker # [ 25.504682] systemd[1]: Started tribuchet build agent 1. worker # [ 25.526916] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1069]: 2026-10-25T16:57:59.978015Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 25.530080] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1069]: 2026-10-25T16:57:59.980918Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 25.532500] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1069]: 2026-10-25T16:57:59.980952Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 25.535249] r47zkml0cjs59f8hnm21y21ar7767vgq-tribuchet-agent[1069]: 2026-10-25T16:57:59.981064Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 25.538645] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. hub # [ 35.171525] tribuchet[1126]: 2026-10-25T16:58:01.050300Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:43222 worker # [ 25.909569] tribuchet[1061]: 2026-10-25T16:58:00.359535Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 25.916403] tribuchet[1061]: 2026-10-25T16:58:00.359672Z INFO tribuchet::worker: reconnecting to hub in 1s hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.09 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.70 seconds) (finished: run the VM test script, in 37.10 seconds) hub # [ 36.542231] tribuchet[1126]: 2026-10-25T16:58:02.421603Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:43224 worker # [ 27.280219] tribuchet[1061]: 2026-10-25T16:58:01.730667Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 27.285863] tribuchet[1061]: 2026-10-25T16:58:01.736459Z INFO tribuchet::worker: reconnecting to hub in 2s worker # [ 29.659206] tribuchet[1061]: 2026-10-25T16:58:04.109970Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 29.661922] tribuchet[1061]: 2026-10-25T16:58:04.113058Z INFO tribuchet::worker: reconnecting to hub in 4s hub # [ 38.922248] tribuchet[1126]: 2026-10-25T16:58:04.800887Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:43228 test script finished in 41.40s cleanup kill QemuMachine (pid 47) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) hub # [2026-10-25T16:58:06Z INFO virtiofsd] Client disconnected, shutting down hub # [2026-10-25T16:58:06Z INFO virtiofsd] Client disconnected, shutting down hub # [2026-10-25T16:58:06Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 48) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) worker # [2026-10-25T16:58:06Z INFO virtiofsd] Client disconnected, shutting down worker # [2026-10-25T16:58:06Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.63 seconds) additionally exposed symbols: hub, worker, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh