Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: hub, worker, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh start all VMs hub: starting vm worker: starting vm hub # Disk image does not exist, creating the virtualisation disk image... hub # Formatting '/build/vm-state-hub/tmp.kVLO94eLWw', 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: b308fd1a-0fb6-44f4-9aac-be7e336f83af hub # Superblock backups stored on blocks: hub # 32768, 98304, 163840, 229376 hub # hub # Allocating group tables: 0/8 done hub # Writing inode tables: 0/8 done hub # Creating journal (8192 blocks): done hub # Writing superblocks and filesystem accounting information: 0/8 done hub # hub # Virtualisation disk image created. hub: QEMU running (pid 47) hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # hub # hub # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC730+7EF2C730 CA00 hub # Press Ctrl-B to configure iPXE (PCI 00:02.0)... hub # hub # hub # hub # hub # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC730 7EF2C730 CB00 hub # Press Ctrl-B to configure iPXE (PCI 00:08.0)... hub # hub # hub # Booting from ROM... hub # Probing EDD (edd=off to disable)... ok hub # [ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 9 18:25:30 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/z3hh008r5wqcnb05kfcwzrf8dxdh30ky-nixos-system-hub-test/init regInfo=/nix/store/w1p6qxdqy4fqwp0p877cv94xdjrjsacy-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. hub # [ 0.000000] BIOS-provided physical RAM map: hub # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable hub # [ 0.000000] BIOS-e820: [mem 0x000000007ffd8000-0x000000007fffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved hub # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved hub # [ 0.000000] NX (Execute Disable) protection: active hub # [ 0.000000] APIC: Static calls initialized hub # [ 0.000000] SMBIOS 2.8 present. hub # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 hub # [ 0.000000] DMI: Memory slots populated: 1/1 hub # [ 0.000000] Hypervisor detected: KVM hub # [ 0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 hub # [ 0.000001] kvm-clock: using sched offset of 567282883 cycles hub # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns hub # [ 0.000009] tsc: Detected 3099.998 MHz processor hub # [ 0.000782] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000 hub # [ 0.000810] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs hub # [ 0.000813] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT hub # [ 0.002974] found SMP MP-table at [mem 0x000f5450-0x000f545f] hub # [ 0.002994] Using GB pages for direct mapping hub # [ 0.003083] RAMDISK: [mem 0x7e34e000-0x7ffcffff] hub # [ 0.003092] ACPI: Early table checksum verification disabled hub # [ 0.003096] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) hub # [ 0.003100] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003105] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003111] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003114] ACPI: FACS 0x000000007FFE0000 000040 hub # [ 0.003115] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003117] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003120] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003121] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) hub # [ 0.003123] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d] hub # [ 0.003124] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219] hub # [ 0.003125] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] hub # [ 0.003126] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385] hub # [ 0.003126] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd] hub # [ 0.003127] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9] hub # [ 0.003127] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421] hub # [ 0.003542] No NUMA configuration found hub # [ 0.003543] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff] hub # [ 0.003548] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff] hub # [ 0.003663] Zone ranges: hub # [ 0.003664] DMA [mem 0x0000000000001000-0x0000000000ffffff] hub # [ 0.003666] DMA32 [mem 0x0000000001000000-0x000000007ffd7fff] hub # [ 0.003667] Normal empty hub # [ 0.003668] Device empty hub # [ 0.003669] Movable zone start for each node hub # [ 0.003669] Early memory node ranges hub # [ 0.003670] node 0: [mem 0x0000000000001000-0x000000000009efff] hub # [ 0.003671] node 0: [mem 0x0000000000100000-0x000000007ffd7fff] hub # [ 0.003672] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff] hub # [ 0.003701] On node 0, zone DMA: 1 pages in unavailable ranges hub # [ 0.003979] On node 0, zone DMA: 97 pages in unavailable ranges hub # [ 0.040068] On node 0, zone DMA32: 40 pages in unavailable ranges hub # [ 0.041063] ACPI: PM-Timer IO Port: 0x608 hub # [ 0.041083] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) hub # [ 0.041119] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 hub # [ 0.041123] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) hub # [ 0.041125] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) hub # [ 0.041126] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) hub # [ 0.041127] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) hub # [ 0.041128] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) hub # [ 0.041131] ACPI: Using ACPI (MADT) for SMP configuration information hub # [ 0.041132] ACPI: HPET id: 0x8086a201 base: 0xfed00000 hub # [ 0.041140] TSC deadline timer available hub # [ 0.041146] CPU topo: Max. logical packages: 1 hub # [ 0.041147] CPU topo: Max. logical dies: 1 hub # [ 0.041147] CPU topo: Max. dies per package: 1 hub # [ 0.041151] CPU topo: Max. threads per core: 1 hub # [ 0.041152] CPU topo: Num. cores per package: 1 hub # [ 0.041152] CPU topo: Num. threads per package: 1 hub # [ 0.041152] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs hub # [ 0.041177] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() hub # [ 0.041216] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] hub # [ 0.041217] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] hub # [ 0.041219] [mem 0xc0000000-0xfed1bfff] available for PCI devices hub # [ 0.041221] Booting paravirtualized kernel on KVM hub # [ 0.041225] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns hub # [ 0.045842] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 hub # [ 0.048196] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 hub # [ 0.048283] kvm-guest: PV spinlocks disabled, single CPU hub # [ 0.048285] 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/z3hh008r5wqcnb05kfcwzrf8dxdh30ky-nixos-system-hub-test/init regInfo=/nix/store/w1p6qxdqy4fqwp0p877cv94xdjrjsacy-closure-info/registration console=ttyS0,115200n8 console=tty0 hub # [ 0.048393] Unknown kernel command line parameters "regInfo=/nix/store/w1p6qxdqy4fqwp0p877cv94xdjrjsacy-closure-info/registration", will be passed to user space. hub # [ 0.048411] random: crng init done hub # [ 0.048412] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes hub # [ 0.050660] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) hub # [ 0.051994] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) hub # [ 0.052046] Fallback order for Node 0: 0 hub # [ 0.052049] Built 1 zonelists, mobility grouping on. Total pages: 524150 hub # [ 0.052050] Policy zone: DMA32 hub # [ 0.054413] mem auto-init: stack:all(zero), heap alloc:on, heap free:off hub # [ 0.061662] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 hub # [ 0.066965] allocated 4194304 bytes of page_ext hub # [ 0.076334] ftrace: allocating 48717 entries in 192 pages hub # [ 0.076339] ftrace: allocated 192 pages with 2 groups hub # [ 0.077197] Dynamic Preempt: lazy hub # [ 0.077343] rcu: Preemptible hierarchical RCU implementation. hub # [ 0.077344] rcu: RCU event tracing is enabled. hub # [ 0.077344] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. hub # [ 0.077346] Trampoline variant of Tasks RCU enabled. hub # [ 0.077347] Rude variant of Tasks RCU enabled. hub # [ 0.077347] Tracing variant of Tasks RCU enabled. hub # [ 0.077348] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. hub # [ 0.077349] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 hub # [ 0.077406] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077408] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.077409] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. hub # [ 0.082241] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 hub # [ 0.082524] rcu: srcu_init: Setting srcu_struct sizes based on contention. hub # [ 0.082533] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns hub # [ 0.082657] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) hub # [ 0.088644] Console: colour VGA+ 80x25 hub # [ 0.088648] printk: legacy console [tty0] enabled hub # [ 0.126678] printk: legacy console [ttyS0] enabled hub # [ 0.280228] ACPI: Core revision 20250807 hub # [ 0.281523] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns hub # [ 0.283895] APIC: Switch to symmetric I/O mode setup hub # [ 0.285329] x2apic enabled hub # [ 0.286368] APIC: Switched APIC routing to: physical x2apic hub # [ 0.288743] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 hub # [ 0.290255] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.292817] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) hub # [ 0.294897] x86/cpu: User Mode Instruction Prevention (UMIP) activated hub # [ 0.295971] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 hub # [ 0.297815] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 hub # [ 0.298823] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto hub # [ 0.300815] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl hub # [ 0.301815] Spectre V2 : Mitigation: Retpolines hub # [ 0.302814] RETBleed: Mitigation: untrained return thunk hub # [ 0.304815] Speculative Return Stack Overflow: Mitigation: SMT disabled hub # [ 0.307820] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization hub # [ 0.308815] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT hub # [ 0.309815] Spectre V2 : Enabling Speculation Barrier for firmware calls hub # [ 0.310816] active return thunk: retbleed_return_thunk hub # [ 0.312813] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier hub # [ 0.313830] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' hub # [ 0.315815] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' hub # [ 0.316815] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' hub # [ 0.317817] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 hub # [ 0.318815] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. hub # [ 0.344768] Freeing SMP alternatives memory: 44K hub # [ 0.345820] pid_max: default: 32768 minimum: 301 hub # [ 0.346908] LSM: initializing lsm=capability,landlock,yama,bpf,ima hub # [ 0.347926] landlock: Up and running. hub # [ 0.348814] Yama: becoming mindful. hub # [ 0.349994] LSM support for eBPF active hub # [ 0.350983] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.351853] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 0.353864] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) hub # [ 0.355371] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 0.355824] ... version: 0 hub # [ 0.356815] ... bit width: 48 hub # [ 0.357815] ... generic counters: 6 hub # [ 0.358815] ... generic bitmap: 000000000000003f hub # [ 0.359815] ... fixed-purpose counters: 0 hub # [ 0.360815] ... fixed-purpose bitmap: 0000000000000000 hub # [ 0.361815] ... value mask: 0000ffffffffffff hub # [ 0.362815] ... max period: 00007fffffffffff hub # [ 0.363815] ... global_ctrl mask: 000000000000003f hub # [ 0.364933] signal: max sigframe size: 1776 hub # [ 0.365948] rcu: Hierarchical SRCU implementation. hub # [ 0.366818] rcu: Max phase no-delay instances is 400. hub # [ 0.371283] smp: Bringing up secondary CPUs ... hub # [ 0.371836] smp: Brought up 1 node, 1 CPU hub # [ 0.372776] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) hub # [ 0.374111] Memory: 1971504K/2096600K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115620K reserved, 0K cma-reserved) hub # [ 0.375749] devtmpfs: initialized hub # [ 0.377106] x86/mm: Memory block size: 128MB hub # [ 0.379272] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) hub # [ 0.380880] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 0.382183] pinctrl core: initialized pinctrl subsystem hub # [ 0.383658] PM: RTC time: 10:18:07, date: 2026-08-31 hub # [ 0.389502] NET: Registered PF_NETLINK/PF_ROUTE protocol family hub # [ 0.391575] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 0.392992] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations hub # [ 0.394214] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations hub # [ 0.394872] audit: initializing netlink subsys (disabled) hub # [ 0.396241] thermal_sys: Registered thermal governor 'fair_share' hub # [ 0.396244] thermal_sys: Registered thermal governor 'bang_bang' hub # [ 0.396879] audit: type=2000 audit(1788171487.283:1): state=initialized audit_enabled=0 res=1 hub # [ 0.399853] thermal_sys: Registered thermal governor 'step_wise' hub # [ 0.399859] thermal_sys: Registered thermal governor 'user_space' hub # [ 0.400823] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 0.401966] cpuidle: using governor menu hub # [ 0.405175] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 0.406305] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] hub # [ 0.406825] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry hub # [ 0.407856] PCI: Using configuration type 1 for base access hub # [ 0.409295] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 0.416086] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages hub # [ 0.416820] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 0.417817] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages hub # [ 0.422818] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 0.431224] ACPI: Added _OSI(Module Device) hub # [ 0.431817] ACPI: Added _OSI(Processor Device) hub # [ 0.434825] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 0.441664] ACPI: 1 ACPI AML tables successfully acquired and loaded hub # [ 0.450180] ACPI: Interpreter enabled hub # [ 0.450835] ACPI: PM: (supports S0 S3 S4 S5) hub # [ 0.453818] ACPI: Using IOAPIC for interrupt routing hub # [ 0.454933] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug hub # [ 0.457823] PCI: Using E820 reservations for host bridge windows hub # [ 0.458961] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 0.465004] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 0.465830] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] hub # [ 0.466917] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] hub # [ 0.467962] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] hub # [ 0.469398] PCI host bridge to bus 0000:00 hub # [ 0.469824] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 0.470819] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] hub # [ 0.471818] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 0.472818] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] hub # [ 0.473818] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 0.474819] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] hub # [ 0.475820] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 0.476995] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint hub # [ 0.478579] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint hub # [ 0.481887] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 0.482845] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] hub # [ 0.483865] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] hub # [ 0.485037] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] hub # [ 0.486746] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.489832] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] hub # [ 0.490833] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] hub # [ 0.491867] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] hub # [ 0.492833] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 0.494900] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.497710] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] hub # [ 0.498833] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 0.499866] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] hub # [ 0.501898] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.504586] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] hub # [ 0.505831] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 0.506863] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] hub # [ 0.508926] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.511681] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] hub # [ 0.512765] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] hub # [ 0.513858] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 0.515889] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint hub # [ 0.517831] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] hub # [ 0.518828] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] hub # [ 0.519859] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] hub # [ 0.522363] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 0.524492] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] hub # [ 0.524829] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] hub # [ 0.525859] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] hub # [ 0.527922] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 0.530698] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] hub # [ 0.531831] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 0.532872] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] hub # [ 0.533833] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] hub # [ 0.536115] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 0.537844] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] hub # [ 0.538869] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 0.541398] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 0.544842] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] hub # [ 0.545835] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] hub # [ 0.546901] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] hub # [ 0.549373] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint hub # [ 0.552845] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] hub # [ 0.553835] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] hub # [ 0.554865] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] hub # [ 0.556986] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.559182] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] hub # [ 0.560337] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.562806] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] hub # [ 0.564305] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 0.565738] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] hub # [ 0.567133] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 0.568620] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] hub # [ 0.570272] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 0.571381] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 0.572307] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 0.574443] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] hub # [ 0.574839] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] hub # [ 0.576518] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint hub # [ 0.578884] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] hub # [ 0.585104] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 hub # [ 0.585956] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 0.586961] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 hub # [ 0.587950] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 hub # [ 0.588950] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 hub # [ 0.589957] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 0.590938] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 hub # [ 0.591932] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 hub # [ 0.592880] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 hub # [ 0.593835] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 hub # [ 0.594836] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 hub # [ 0.595836] ACPI: PCI: Interrupt link GSID configured for IRQ 19 hub # [ 0.596834] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 hub # [ 0.597832] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 hub # [ 0.598837] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 hub # [ 0.599870] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 hub # [ 0.601919] iommu: Default domain type: Translated hub # [ 0.602825] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 0.604094] ACPI: bus type USB registered hub # [ 0.604887] usbcore: registered new interface driver usbfs hub # [ 0.605835] usbcore: registered new interface driver hub hub # [ 0.606835] usbcore: registered new device driver usb hub # [ 0.608651] NetLabel: Initializing hub # [ 0.609428] NetLabel: domain hash size = 128 hub # [ 0.609816] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 0.610866] NetLabel: unlabeled traffic allowed by default hub # [ 0.611828] PCI: Using ACPI for IRQ routing hub # [ 0.721310] pci 0000:00:01.0: vgaarb: setting as boot VGA device hub # [ 0.721811] pci 0000:00:01.0: vgaarb: bridge control possible hub # [ 0.721811] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none hub # [ 0.721834] vgaarb: loaded hub # [ 0.722896] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 hub # [ 0.723826] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 0.728967] clocksource: Switched to clocksource kvm-clock hub # [ 0.733172] VFS: Disk quotas dquot_6.6.0 hub # [ 0.734324] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) hub # [ 0.736320] pnp: PnP ACPI init hub # [ 0.737405] ACPI: IRQ 4 override to edge(!), high(!) hub # [ 0.738931] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved hub # [ 0.741180] pnp: PnP ACPI: found 6 devices hub # [ 0.748892] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns hub # [ 0.751297] clocksource: Switched to clocksource acpi_pm hub # [ 0.753084] NET: Registered PF_INET protocol family hub # [ 0.755402] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) hub # [ 0.773614] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) hub # [ 0.775728] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) hub # [ 0.777625] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) hub # [ 0.779624] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) hub # [ 0.781505] TCP: Hash tables configured (established 16384 bind 16384) hub # [ 0.783194] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) hub # [ 0.785243] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.787014] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) hub # [ 0.789021] NET: Registered PF_UNIX/PF_LOCAL protocol family hub # [ 0.790576] NET: Registered PF_XDP protocol family hub # [ 0.792020] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] hub # [ 0.793566] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] hub # [ 0.795039] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] hub # [ 0.796971] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] hub # [ 0.798831] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] hub # [ 0.800547] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] hub # [ 0.803167] ACPI: \_SB_.GSIA: Enabled at IRQ 16 hub # [ 0.806333] ACPI: \_SB_.GSIB: Enabled at IRQ 17 hub # [ 0.809222] ACPI: \_SB_.GSIC: Enabled at IRQ 18 hub # [ 0.812147] ACPI: \_SB_.GSID: Enabled at IRQ 19 hub # [ 0.814990] PCI: CLS 0 bytes, default 64 hub # [ 0.816470] Trying to unpack rootfs image as initramfs... hub # [ 0.821731] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns hub # [ 0.858649] Initialise system trusted keyrings hub # [ 0.862368] workingset: timestamp_bits=40 max_order=19 bucket_order=0 hub # [ 0.881812] Key type asymmetric registered hub # [ 0.888353] Asymmetric key parser 'x509' registered hub # [ 0.889829] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) hub # [ 0.895478] io scheduler mq-deadline registered hub # [ 0.896656] io scheduler kyber registered hub # [ 0.900931] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled hub # [ 0.902766] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A hub # [ 0.910489] Linux agpgart interface v0.103 hub # [ 0.911637] ACPI: bus type drm_connector registered hub # [ 0.915831] usbcore: registered new interface driver usbserial_generic hub # [ 0.917451] usbserial: USB Serial support registered for generic hub # [ 0.922345] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled hub # [ 0.927400] drop_monitor: Initializing network drop monitor service hub # [ 0.931406] NET: Registered PF_INET6 protocol family hub # [ 0.935866] Segment Routing with IPv6 hub # [ 0.937014] In-situ OAM (IOAM) with IPv6 hub # [ 0.940760] IPI shorthand broadcast: enabled hub # [ 0.946240] sched_clock: Marking stable (740027007, 205279248)->(1121060502, -175754247) hub # [ 0.953448] registered taskstats version 1 hub # [ 0.954736] Loading compiled-in X.509 certificates hub # [ 0.966617] Demotion targets for Node 0: null hub # [ 0.969377] Key type .fscrypt registered hub # [ 0.972313] Key type fscrypt-provisioning registered hub # [ 0.973822] ima: No TPM chip found, activating TPM-bypass! hub # [ 0.977382] ima: Allocated hash algorithm: sha1 hub # [ 0.978676] ima: No architecture policies found hub # [ 0.984368] PM: Magic number: 6:673:326 hub # [ 0.988730] RAS: Correctable Errors collector initialized. hub # [ 1.000619] clk: Disabling unused clocks hub # [ 1.001784] PM: genpd: Disabling unused power domains hub # [ 1.219977] Freeing initrd memory: 29192K hub # [ 1.224155] Freeing unused decrypted memory: 2028K hub # [ 1.227183] Freeing unused kernel image (initmem) memory: 3644K hub # [ 1.228884] Write protecting the kernel read-only data: 32768k hub # [ 1.231211] Freeing unused kernel image (text/rodata gap) memory: 1220K hub # [ 1.233426] Freeing unused kernel image (rodata/data gap) memory: 756K hub # [ 1.274988] x86/mm: Checked W+X mappings: passed, no W+X pages found. hub # [ 1.276726] Run /init as init process hub # [ 1.286925] systemd[1]: Inserted module 'autofs4' hub # [ 1.304861] fuse: init (API version 7.45) hub # [ 1.311608] ACPI: \_SB_.GSIG: Enabled at IRQ 22 hub # [ 1.314857] ACPI: \_SB_.GSIH: Enabled at IRQ 23 hub # [ 1.318995] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 1.322233] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 1.352807] systemd[1]: Successfully made /usr/ read-only. hub # [ 1.689446] systemd[1]: systemd 261.1 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.696616] systemd[1]: Detected virtualization kvm. hub # [ 1.697883] systemd[1]: Detected architecture x86-64. hub # [ 1.699125] systemd[1]: Running in initrd. hub # [ 1.700626] systemd[1]: Initializing machine ID from random generator. hub # [ 1.702314] systemd[1]: Hostname set to . hub # [ 1.874253] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 1.913059] systemd[1]: Queued start job for default target Initrd Default Target. hub # [ 1.918025] systemd[1]: Created slice Slice /system/modprobe. hub # [ 1.920202] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. hub # [ 1.922325] systemd[1]: Expecting device /dev/disk/by-label/nixos... hub # [ 1.923933] systemd[1]: Reached target Path Units. hub # [ 1.925183] systemd[1]: Reached target Slice Units. hub # [ 1.926488] systemd[1]: Reached target Swaps. hub # [ 1.927673] systemd[1]: Reached target Timer Units. hub # [ 1.929168] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 1.931025] systemd[1]: Listening on Journal Socket (/dev/log). hub # [ 1.932706] systemd[1]: Listening on Journal Sockets. hub # [ 1.934172] systemd[1]: Listening on udev Control Socket. hub # [ 1.935646] systemd[1]: Listening on udev Kernel Socket. hub # [ 1.937008] systemd[1]: Reached target Socket Units. hub # [ 1.939451] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 1.944580] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 1.953727] systemd[1]: Starting Load Kernel Module configfs... hub # [ 1.966057] systemd[1]: Starting Journal Service... hub # [ 1.980460] systemd[1]: Starting Load Kernel Modules... hub # [ 1.989307] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 1.992185] netfs: FS-Cache loaded hub # [ 2.005481] systemd[1]: Starting Coldplug All udev Devices... hub # [ 2.009545] 9pnet: Installing 9P2000 support hub # [ 2.025490] systemd[1]: Finished Create List of Static Device Nodes. hub # [ 2.031439] systemd-journald[67]: Collecting audit messages is disabled. hub # [ 2.036161] systemd[1]: modprobe@configfs.service: Deactivated successfully. hub # [ 2.048386] systemd[1]: Finished Load Kernel Module configfs. hub # [ 2.061976] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. hub # [ 2.076361] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev hub # [ 2.080663] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. hub # [ 2.094686] systemd[1]: Finished Load Kernel Module 9pnet_virtio. hub # [ 2.109954] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 2.131231] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 2.155510] systemd[1]: Finished Load Kernel Modules. hub # [ 2.165714] systemd[1]: Starting Apply Kernel Variables... hub # [ 2.182584] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 2.194891] systemd[1]: Starting Create Static Device Nodes in /dev... hub # [ 2.214547] systemd[1]: Finished Apply Kernel Variables. hub # [ 2.227450] systemd[1]: Started Journal Service. hub # [ 2.026291] systemd-modules-load[68]: Inserted module 'dm_mod' hub # [ 2.030096] systemd-modules-load[68]: Inserted module 'virtio_balloon' hub # [ 2.032412] systemd-modules-load[68]: Inserted module 'virtio_gpu' hub # [ 2.038209] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 2.044758] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 2.047127] systemd[1]: Reached target Local File Systems. hub # [ 2.051094] systemd[1]: Starting Create System Files and Directories... hub # [ 2.057710] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 2.080539] systemd[1]: Finished Create System Files and Directories. hub # [ 2.100518] systemd[1]: Finished Coldplug All udev Devices. hub # [ 2.103804] systemd-udevd[82]: Using default interface naming scheme 'v261'. hub # [ 2.121103] systemd[1]: Started Rule-based Manager for Device Events and Files. hub # [ 2.122857] systemd[1]: Reached target System Initialization. hub # [ 2.124103] systemd[1]: Reached target Basic System. hub # [ 2.538798] virtio_blk virtio5: 1/0/0 default/read/poll queues hub # [ 2.573395] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub # [ 2.598953] uhci_hcd 0000:00:1d.0: UHCI Host Controller hub # [ 2.605841] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 2.624145] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1 hub # [ 2.632323] uhci_hcd 0000:00:1d.0: detected 2 ports hub # [ 2.633481] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 hub # [ 2.637383] serio: i8042 KBD port at 0x60,0x64 irq 1 hub # [ 2.643779] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 2.650337] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.652094] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.670551] usb usb1: Product: UHCI Host Controller hub # [ 2.678649] usb usb1: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 2.687838] usb usb1: SerialNumber: 0000:00:1d.0 hub # [ 2.696931] hub 1-0:1.0: USB hub found hub # [ 2.700511] hub 1-0:1.0: 2 ports detected hub # [ 2.498119] systemd[1]: Starting Virtual Console Setup... hub # [ 2.706516] ehci-pci 0000:00:1d.7: EHCI Host Controller hub # [ 2.707861] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2 hub # [ 2.713732] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 hub # [ 2.724348] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 hub # [ 2.727106] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 hub # [ 2.731316] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.734206] usb usb2: Product: EHCI Host Controller hub # [ 2.735188] usb usb2: Manufacturer: Linux 6.18.44 ehci_hcd hub # [ 2.738325] usb usb2: SerialNumber: 0000:00:1d.7 hub # [ 2.741491] hub 2-0:1.0: USB hub found hub # [ 2.744373] hub 2-0:1.0: 6 ports detected hub # [ 2.545749] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 2.549569] systemd[1]: Finished Virtual Console Setup. hub # [ 2.767724] hub 1-0:1.0: USB hub found hub # [ 2.769419] hub 1-0:1.0: 2 ports detected hub # [ 2.776306] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 2.777435] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 2.785518] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 hub # [ 2.583129] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.592847] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 2.595823] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. hub # [ 2.806849] uhci_hcd 0000:00:1d.1: detected 2 ports hub # [ 2.817168] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 hub # [ 2.829485] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.831134] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.838497] usb usb3: Product: UHCI Host Controller hub # [ 2.846002] usb usb3: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 2.848308] usb usb3: SerialNumber: 0000:00:1d.1 hub # [ 2.647437] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 2.650355] systemd[1]: Reached target Initrd Root Device. hub # [ 2.653304] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... hub # [ 2.861398] hub 3-0:1.0: USB hub found hub # [ 2.864074] hub 3-0:1.0: 2 ports detected hub # [ 2.866381] SCSI subsystem initialized hub # [ 2.877232] uhci_hcd 0000:00:1d.2: UHCI Host Controller hub # [ 2.883688] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 hub # [ 2.890334] uhci_hcd 0000:00:1d.2: detected 2 ports hub # [ 2.687921] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks hub # [ 2.896163] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 hub # [ 2.695209] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. hub # [ 2.904647] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 hub # [ 2.909351] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 2.913528] usb usb4: Product: UHCI Host Controller hub # [ 2.916362] usb usb4: Manufacturer: Linux 6.18.44 uhci_hcd hub # [ 2.919357] usb usb4: SerialNumber: 0000:00:1d.2 hub # [ 2.922847] hub 4-0:1.0: USB hub found hub # [ 2.927546] hub 4-0:1.0: 2 ports detected hub # [ 2.971090] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode hub # [ 2.976375] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) hub # [ 2.978739] ahci 0000:00:1f.2: flags: 64bit ncq only hub # [ 2.984325] usb 2-1: new high-speed USB device number 2 using ehci-pci hub # [ 2.986017] scsi host0: ahci hub # [ 2.988486] scsi host1: ahci hub # [ 2.990670] scsi host2: ahci hub # [ 2.993176] scsi host3: ahci hub # [ 2.995204] scsi host4: ahci hub # [ 2.997754] scsi host5: ahci hub # [ 2.999459] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 hub # [ 3.002184] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 hub # [ 3.004093] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 hub # [ 3.005999] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 hub # [ 3.007939] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 hub # [ 3.009939] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 hub # [ 2.818099] systemd[1]: Mounting /sysroot... hub # [ 3.114380] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 hub # [ 3.116094] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 hub # [ 3.118083] usb 2-1: Product: QEMU USB Tablet hub # [ 3.119124] usb 2-1: Manufacturer: QEMU hub # [ 3.120123] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1 hub # [ 3.133465] hid: raw HID events driver (C) Jiri Kosina hub # [ 3.320764] ata4: SATA link down (SStatus 0 SControl 300) hub # [ 3.322472] ata1: SATA link down (SStatus 0 SControl 300) hub # [ 3.323778] ata5: SATA link down (SStatus 0 SControl 300) hub # [ 3.325207] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 3.326614] ata6: SATA link down (SStatus 0 SControl 300) hub # [ 3.327999] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) hub # [ 3.329415] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 hub # [ 3.330658] ata3.00: applying bridge limits hub # [ 3.331742] ata3.00: configured for UDMA/100 hub # [ 3.333230] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 3.390030] usbcore: registered new interface driver usbhid hub # [ 3.394690] usbhid: USB HID core driver hub # [ 3.423827] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input2 hub # [ 3.426053] 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 # [ 3.432225] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray hub # [ 3.441480] EXT4-fs (vda): mounted filesystem b308fd1a-0fb6-44f4-9aac-be7e336f83af r/w with ordered data mode. Quota mode: none. hub # [ 3.246796] systemd[1]: Mounted /sysroot. hub # [ 3.454130] cdrom: Uniform CD-ROM driver Revision: 3.20 hub # [ 3.250144] systemd[1]: Reached target Initrd Root File System. hub # [ 3.251654] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 3.267665] systemd-sysroot-fstab-check[144]: /sysroot should be mounted in the initrd, will request daemon-reload. hub # [ 3.272113] systemd[1]: Reload requested from client PID 144 ('systemd-sysroot') (unit initrd-parse-etc.service)... hub # [ 3.274233] systemd[1]: Reloading... hub # [ 3.359906] systemd[1]: Reloading finished in 87 ms. hub # [ 3.368489] systemd-sysroot-fstab-check[144]: Requesting initrd-fs.target/start/replace... hub # [ 3.372130] systemd-sysroot-fstab-check[144]: Requesting swap.target/start/replace... hub # [ 3.378224] systemd[1]: initrd-parse-etc.service: Deactivated successfully. hub # [ 3.381077] systemd[1]: Finished Mountpoints Configured in the Real Root. hub # [ 3.382378] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. hub # [ 3.384621] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 3.818103] systemd[1]: Mounting /sysroot/nix/.ro-store... hub # [ 3.822859] systemd[1]: Mounting /sysroot/nix/.rw-store... hub # [ 3.826912] systemd[1]: Mounting /sysroot/run... hub # [ 3.831989] systemd[1]: Mounting /sysroot/tmp/shared... hub # [ 3.839626] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 4.066864] 9p: Installing v9fs 9p2000 file system support hub # [ 3.874619] systemd[1]: Mounted /sysroot/nix/.ro-store. hub # [ 3.878166] systemd[1]: Mounted /sysroot/nix/.rw-store. hub # [ 3.880197] systemd[1]: Mounted /sysroot/run. hub # [ 3.882212] systemd[1]: Mounted /sysroot/tmp/shared. hub # [ 3.883539] systemd[1]: Mounted /sysroot/tmp/xchg. hub # [ 3.887823] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 3.897646] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 3.900099] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 3.902639] systemd[1]: Mounting /sysroot/nix/store... hub # [ 3.923267] systemd[1]: Mounted /sysroot/nix/store. hub # [ 3.924867] systemd[1]: Reached target Initrd File Systems. hub # [ 3.927090] systemd[1]: Starting Find NixOS closure... hub # [ 3.930160] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... hub # [ 3.952981] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. hub # [ 3.960613] systemd[1]: Finished Find NixOS closure. hub # [ 3.962401] systemd[1]: Reached target Initrd Default Target. hub # [ 3.964652] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... hub # [ 3.983312] systemd[1]: Stopped target Initrd Default Target. hub # [ 3.984812] systemd[1]: Stopped target Basic System. hub # [ 3.987217] systemd[1]: Stopped target Initrd Root Device. hub # [ 3.988585] systemd[1]: Stopped target Path Units. hub # [ 3.989601] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. hub # [ 3.991053] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. hub # [ 3.993056] systemd[1]: Stopped target Slice Units. hub # [ 3.994690] systemd[1]: Stopped target Socket Units. hub # [ 3.996369] systemd[1]: Stopped target System Initialization. hub # [ 3.998104] systemd[1]: Stopped target Swaps. hub # [ 3.999383] systemd[1]: Stopped target Timer Units. hub # [ 4.001198] systemd[1]: dbus.socket: Deactivated successfully. hub # [ 4.002551] systemd[1]: Closed D-Bus System Message Bus Socket. hub # [ 4.004178] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. hub # [ 4.005706] systemd[1]: Stopped Find NixOS closure. hub # [ 4.007222] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 4.009790] systemd[1]: Starting rw-sysroot-nix-store.service... hub # [ 4.012189] systemd[1]: systemd-sysctl.service: Deactivated successfully. hub # [ 4.013750] systemd[1]: Stopped Apply Kernel Variables. hub # [ 4.015332] systemd[1]: systemd-modules-load.service: Deactivated successfully. hub # [ 4.017118] systemd[1]: Stopped Load Kernel Modules. hub # [ 4.019080] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. hub # [ 4.020679] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. hub # [ 4.022497] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. hub # [ 4.025159] systemd[1]: Stopped Create System Files and Directories. hub # [ 4.026727] systemd[1]: Stopped target Local File Systems. hub # [ 4.028258] systemd[1]: Stopped target Preparation for Local File Systems. hub # [ 4.030169] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. hub # [ 4.032175] systemd[1]: Stopped Coldplug All udev Devices. hub # [ 4.034201] systemd[1]: Stopping Rule-based Manager for Device Events and Files... hub # [ 4.036756] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 4.039126] systemd[1]: Stopped Virtual Console Setup. hub # [ 4.052532] systemd[1]: initrd-cleanup.service: Deactivated successfully. hub # [ 4.055250] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. hub # [ 4.057773] systemd[1]: systemd-udevd.service: Deactivated successfully. hub # [ 4.060150] systemd[1]: Stopped Rule-based Manager for Device Events and Files. hub # [ 4.061709] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. hub # [ 4.063383] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 4.066107] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. hub # [ 4.067635] systemd[1]: Closed udev Control Socket. hub # [ 4.069498] systemd[1]: Starting Cleanup udev Database... hub # [ 4.071211] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. hub # [ 4.072774] systemd[1]: Stopped Create Static Device Nodes in /dev. hub # [ 4.075165] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. hub # [ 4.076814] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. hub # [ 4.078301] systemd[1]: kmod-static-nodes.service: Deactivated successfully. hub # [ 4.079803] systemd[1]: Stopped Create List of Static Device Nodes. hub # [ 4.092192] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. hub # [ 4.095080] systemd[1]: Finished Cleanup udev Database. hub # [ 4.096285] systemd[1]: Reached target Switch Root. hub # [ 4.098150] systemd[1]: Starting NixOS Activation... hub # [ 4.359623] initrd-nixos-activation-start[197]: booting system configuration /nix/store/z3hh008r5wqcnb05kfcwzrf8dxdh30ky-nixos-system-hub-test hub # [ 4.403066] initrd-nixos-activation-start[197]: running activation script... hub # [ 4.711397] initrd-nixos-activation-start[220]: setting up /etc... hub # [ 4.928310] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. hub # [ 4.931116] systemd[1]: Finished NixOS Activation. hub # [ 4.933869] systemd[1]: Starting Switch Root... hub # [ 4.948480] systemd[1]: Switching root. hub # [ 5.276737] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). hub # [ 5.364714] NET: Registered PF_VSOCK protocol family hub # [ 5.742832] systemd[1]: systemd 261.1 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 # [ 5.749174] systemd[1]: Detected virtualization kvm. hub # [ 5.750434] systemd[1]: Detected architecture x86-64. hub # [ 5.751719] systemd[1]: Detected first boot. hub # [ 5.754747] systemd[1]: Initializing machine ID from random generator. worker # Disk image does not exist, creating the virtualisation disk image... worker: QEMU running (pid 48) worker # Formatting '/build/vm-state-worker/tmp.FmCqZzzs4x', fmt=raw size=1073741824 worker # mke2fs 1.47.4 (6-Mar-2025) worker # Discarding device blocks: 0/262144 done worker # Creating filesystem with 262144 4k blocks and 65536 inodes worker # Filesystem UUID: af339342-6900-4166-a2fd-1b2b716286e2 worker # Superblock backups stored on blocks: worker # 32768, 98304, 163840, 229376 worker # worker # Allocating group tables: 0/8 done worker # Writing inode tables: 0/8 done worker # Creating journal (8192 blocks): done worker # Writing superblocks and filesystem accounting information: 0/8 done worker # worker # Virtualisation disk image created. worker # Creating Nix store image... worker # Created Nix store image. (finished: start all VMs, in 6.77 seconds) hub: waiting for unit headscale hub: waiting for the VM to finish booting worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) hub # [ 5.962974] systemd[1]: bpf-restrict-fs: LSM BPF program attached hub # [ 6.059306] systemd[1]: Applying preset policy. 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:08.0 CB00 PCI2.10 PnP PMM 7EFCC610 7EF2C610 CB00 worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)... worker # worker # worker # Booting from ROM... hub # [ 6.375551] systemd[1]: Populated /etc with preset unit settings. worker # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 9 18:25:30 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/iadhhf74gclqsnjqdw08h77n0g84mcf9-nixos-system-worker-test/init regInfo=/nix/store/cy9y2zdsab7z55sb89c8jvvnlvyp6vkh-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. worker # [ 0.000000] BIOS-provided physical RAM map: worker # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd4fff] usable worker # [ 0.000000] BIOS-e820: [mem 0x000000007ffd5000-0x000000007fffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved worker # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved worker # [ 0.000000] NX (Execute Disable) protection: active worker # [ 0.000000] APIC: Static calls initialized worker # [ 0.000000] SMBIOS 2.8 present. worker # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 worker # [ 0.000000] DMI: Memory slots populated: 1/1 worker # [ 0.000000] Hypervisor detected: KVM worker # [ 0.000000] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 worker # [ 0.000000] kvm-clock: using sched offset of 523350399 cycles worker # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns worker # [ 0.000006] tsc: Detected 3099.998 MHz processor worker # [ 0.000726] last_pfn = 0x7ffd5 max_arch_pfn = 0x400000000 worker # [ 0.000754] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs worker # [ 0.000757] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT worker # [ 0.002778] found SMP MP-table at [mem 0x000f5450-0x000f545f] worker # [ 0.002793] Using GB pages for direct mapping worker # [ 0.002860] RAMDISK: [mem 0x7e33b000-0x7ffcffff] worker # [ 0.002867] ACPI: Early table checksum verification disabled worker # [ 0.002870] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) worker # [ 0.002873] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002878] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002884] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002886] ACPI: FACS 0x000000007FFE0000 000040 worker # [ 0.002888] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002890] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002892] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002894] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) worker # [ 0.002896] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d] worker # [ 0.002897] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219] worker # [ 0.002897] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] worker # [ 0.002898] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385] worker # [ 0.002898] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd] worker # [ 0.002899] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9] worker # [ 0.002899] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421] worker # [ 0.003280] No NUMA configuration found worker # [ 0.003282] Faking a node at [mem 0x0000000000000000-0x000000007ffd4fff] worker # [ 0.003285] NODE_DATA(0) allocated [mem 0x7e335a80-0x7e33afff] worker # [ 0.003377] Zone ranges: worker # [ 0.003378] DMA [mem 0x0000000000001000-0x0000000000ffffff] worker # [ 0.003379] DMA32 [mem 0x0000000001000000-0x000000007ffd4fff] worker # [ 0.003380] Normal empty worker # [ 0.003381] Device empty worker # [ 0.003382] Movable zone start for each node worker # [ 0.003382] Early memory node ranges worker # [ 0.003383] node 0: [mem 0x0000000000001000-0x000000000009efff] worker # [ 0.003384] node 0: [mem 0x0000000000100000-0x000000007ffd4fff] worker # [ 0.003385] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd4fff] worker # [ 0.003414] On node 0, zone DMA: 1 pages in unavailable ranges worker # [ 0.003677] On node 0, zone DMA: 97 pages in unavailable ranges worker # [ 0.037147] On node 0, zone DMA32: 43 pages in unavailable ranges worker # [ 0.038042] ACPI: PM-Timer IO Port: 0x608 worker # [ 0.038058] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) worker # [ 0.038086] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 worker # [ 0.038090] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) worker # [ 0.038091] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) worker # [ 0.038092] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) worker # [ 0.038093] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) worker # [ 0.038094] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) worker # [ 0.038097] ACPI: Using ACPI (MADT) for SMP configuration information worker # [ 0.038098] ACPI: HPET id: 0x8086a201 base: 0xfed00000 worker # [ 0.038103] TSC deadline timer available worker # [ 0.038107] CPU topo: Max. logical packages: 1 worker # [ 0.038108] CPU topo: Max. logical dies: 1 worker # [ 0.038108] CPU topo: Max. dies per package: 1 worker # [ 0.038112] CPU topo: Max. threads per core: 1 worker # [ 0.038112] CPU topo: Num. cores per package: 1 worker # [ 0.038113] CPU topo: Num. threads per package: 1 worker # [ 0.038113] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs worker # [ 0.038132] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() worker # [ 0.038168] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] worker # [ 0.038170] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] worker # [ 0.038171] [mem 0xc0000000-0xfed1bfff] available for PCI devices worker # [ 0.038173] Booting paravirtualized kernel on KVM worker # [ 0.038176] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns worker # [ 0.042634] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 worker # [ 0.044709] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 worker # [ 0.044749] kvm-guest: PV spinlocks disabled, single CPU worker # [ 0.044751] 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/iadhhf74gclqsnjqdw08h77n0g84mcf9-nixos-system-worker-test/init regInfo=/nix/store/cy9y2zdsab7z55sb89c8jvvnlvyp6vkh-closure-info/registration console=ttyS0,115200n8 console=tty0 worker # [ 0.044849] Unknown kernel command line parameters "regInfo=/nix/store/cy9y2zdsab7z55sb89c8jvvnlvyp6vkh-closure-info/registration", will be passed to user space. worker # [ 0.044868] random: crng init done worker # [ 0.044869] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes worker # [ 0.046918] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) worker # [ 0.047936] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) worker # [ 0.047966] Fallback order for Node 0: 0 worker # [ 0.047968] Built 1 zonelists, mobility grouping on. Total pages: 524147 worker # [ 0.047969] Policy zone: DMA32 worker # [ 0.050159] mem auto-init: stack:all(zero), heap alloc:on, heap free:off worker # [ 0.055887] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 worker # [ 0.061437] allocated 4194304 bytes of page_ext worker # [ 0.070607] ftrace: allocating 48717 entries in 192 pages worker # [ 0.070611] ftrace: allocated 192 pages with 2 groups worker # [ 0.071447] Dynamic Preempt: lazy worker # [ 0.071646] rcu: Preemptible hierarchical RCU implementation. worker # [ 0.071647] rcu: RCU event tracing is enabled. worker # [ 0.071647] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. worker # [ 0.071648] Trampoline variant of Tasks RCU enabled. worker # [ 0.071649] Rude variant of Tasks RCU enabled. worker # [ 0.071649] Tracing variant of Tasks RCU enabled. worker # [ 0.071650] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. worker # [ 0.071650] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 worker # [ 0.071667] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.071669] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.071670] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. worker # [ 0.076195] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 worker # [ 0.076466] rcu: srcu_init: Setting srcu_struct sizes based on contention. worker # [ 0.076473] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns worker # [ 0.076587] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) worker # [ 0.083714] Console: colour VGA+ 80x25 worker # [ 0.083718] printk: legacy console [tty0] enabled worker # [ 0.127029] printk: legacy console [ttyS0] enabled worker # [ 0.283174] ACPI: Core revision 20250807 worker # [ 0.284867] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns worker # [ 0.287093] APIC: Switch to symmetric I/O mode setup worker # [ 0.288449] x2apic enabled worker # [ 0.289520] APIC: Switched APIC routing to: physical x2apic worker # [ 0.291890] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 worker # [ 0.293418] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.296031] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998) worker # [ 0.298115] x86/cpu: User Mode Instruction Prevention (UMIP) activated worker # [ 0.299162] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 worker # [ 0.301028] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 worker # [ 0.302034] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto worker # [ 0.303037] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl worker # [ 0.305029] Spectre V2 : Mitigation: Retpolines worker # [ 0.306029] RETBleed: Mitigation: untrained return thunk worker # [ 0.307029] Speculative Return Stack Overflow: Mitigation: SMT disabled worker # [ 0.309032] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization worker # [ 0.310029] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT worker # [ 0.311029] Spectre V2 : Enabling Speculation Barrier for firmware calls worker # [ 0.312028] active return thunk: retbleed_return_thunk worker # [ 0.314034] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier worker # [ 0.315047] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' worker # [ 0.316028] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' worker # [ 0.317028] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' worker # [ 0.319029] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 worker # [ 0.320029] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. worker # [ 0.345439] Freeing SMP alternatives memory: 44K worker # [ 0.346029] pid_max: default: 32768 minimum: 301 worker # [ 0.347102] LSM: initializing lsm=capability,landlock,yama,bpf,ima worker # [ 0.349117] landlock: Up and running. worker # [ 0.350028] Yama: becoming mindful. worker # [ 0.351173] LSM support for eBPF active worker # [ 0.352143] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) worker # [ 0.353067] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) hub # [ 6.751191] systemd[1]: initrd-switch-root.service: Deactivated successfully. hub # [ 6.753126] systemd[1]: Stopped initrd-switch-root.service. worker # [ 0.356663] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0) worker # [ 0.357442] Performance Events: Fam17h+ core perfctr, AMD PMU driver. hub # [ 6.756181] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 0.358031] ... version: 0 worker # [ 0.359029] ... bit width: 48 hub # [ 6.758799] systemd[1]: Created slice Slice /system/getty. worker # [ 0.360076] ... generic counters: 6 worker # [ 0.361029] ... generic bitmap: 000000000000003f hub # [ 6.760455] systemd[1]: Created slice User and Session Slice. worker # [ 0.362029] ... fixed-purpose counters: 0 hub # [ 6.761700] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 0.363029] ... fixed-purpose bitmap: 0000000000000000 hub # [ 6.763317] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 0.364029] ... value mask: 0000ffffffffffff hub # [ 6.764737] systemd[1]: Expecting device /dev/hvc0... worker # [ 0.365029] ... max period: 00007fffffffffff hub # [ 6.765715] systemd[1]: Expecting device /dev/ttyS0... worker # [ 0.366029] ... global_ctrl mask: 000000000000003f hub # [ 6.766764] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 0.367107] signal: max sigframe size: 1776 hub # [ 6.767900] systemd[1]: Stopped target initrd-fs.target. worker # [ 0.368117] rcu: Hierarchical SRCU implementation. hub # [ 6.768924] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 0.369033] rcu: Max phase no-delay instances is 400. hub # [ 6.769997] systemd[1]: Stopped target initrd-switch-root.target. hub # [ 6.771180] systemd[1]: Reached target Virtual Machines and Containers. hub # [ 6.772451] systemd[1]: Reached target Path Units. hub # [ 6.773439] systemd[1]: Reached target Remote File Systems. worker # [ 0.373215] smp: Bringing up secondary CPUs ... worker # [ 0.374041] smp: Brought up 1 node, 1 CPU hub # [ 6.774705] systemd[1]: Reached target Slice Units. worker # [ 0.375002] smpboot: Total of 1 processors activated (6199.99 BogoMIPS) hub # [ 6.776621] systemd[1]: Reached target Swaps. worker # [ 0.376172] Memory: 1971388K/2096588K available (17211K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115696K reserved, 0K cma-reserved) worker # [ 0.377343] devtmpfs: initialized hub # [ 6.780428] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 0.378206] x86/mm: Memory block size: 128MB hub # [ 6.784152] systemd[1]: Listening on Process Core Dump Socket. worker # [ 0.379828] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) worker # [ 0.381062] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). hub # [ 6.787037] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 0.382126] pinctrl core: initialized pinctrl subsystem worker # [ 0.383326] PM: RTC time: 10:18:13, date: 2026-08-31 hub # [ 6.790075] systemd[1]: Listening on Factory Reset Management. worker # [ 0.386687] NET: Registered PF_NETLINK/PF_ROUTE protocol family worker # [ 0.387446] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations hub # [ 6.791417] systemd[1]: Listening on Hostname Service Socket. worker # [ 0.388062] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations worker # [ 0.389306] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations worker # [ 0.390043] audit: initializing netlink subsys (disabled) hub # [ 6.800720] systemd[1]: Starting Journal Log Access Socket... worker # [ 0.391358] thermal_sys: Registered thermal governor 'fair_share' hub # [ 6.803197] systemd[1]: Listening on Journal Audit Socket. worker # [ 0.391360] thermal_sys: Registered thermal governor 'bang_bang' worker # [ 0.392032] audit: type=2000 audit(1788171493.828:1): state=initialized audit_enabled=0 res=1 worker # [ 0.394032] thermal_sys: Registered thermal governor 'step_wise' hub # [ 6.808093] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 0.394034] thermal_sys: Registered thermal governor 'user_space' worker # [ 0.395029] thermal_sys: Registered thermal governor 'power_allocator' hub # [ 6.810184] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 0.396055] cpuidle: using governor menu hub # [ 6.812600] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 0.398920] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 hub # [ 6.814507] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 0.400295] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] worker # [ 0.401032] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry worker # [ 0.402042] PCI: Using configuration type 1 for base access hub # [ 6.821585] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 0.403209] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. hub # [ 6.823074] systemd[1]: Listening on udev Control Socket. hub # [ 6.824397] systemd[1]: Listening on udev Varlink Socket. hub # [ 6.827754] systemd[1]: Mounting Huge Pages File System... worker # [ 0.410047] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages worker # [ 0.411031] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page hub # [ 6.833265] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 0.416032] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages worker # [ 0.417038] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page hub # [ 6.838981] systemd[1]: Mounting Kernel Debug File System... hub # [ 6.843325] systemd[1]: Mounting Kernel Trace File System... worker # [ 0.428283] ACPI: Added _OSI(Module Device) worker # [ 0.429030] ACPI: Added _OSI(Processor Device) hub # [ 6.852469] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 0.432031] ACPI: Added _OSI(Processor Aggregator Device) hub # [ 6.857841] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 0.437472] ACPI: 1 ACPI AML tables successfully acquired and loaded worker # [ 0.441321] ACPI: Interpreter enabled worker # [ 0.442044] ACPI: PM: (supports S0 S3 S4 S5) worker # [ 0.445031] ACPI: Using IOAPIC for interrupt routing worker # [ 0.446093] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug worker # [ 0.449029] PCI: Using E820 reservations for host bridge windows worker # [ 0.450165] ACPI: Enabled 2 GPEs in block 00 to 3F hub # [ 6.878689] systemd[1]: Starting Load Kernel Module configfs... worker # [ 0.455903] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) hub # [ 6.884437] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 0.457035] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] worker # [ 0.458091] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] worker # [ 0.459215] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] worker # [ 0.460561] PCI host bridge to bus 0000:00 worker # [ 0.461039] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] hub # [ 6.892331] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 0.462030] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] worker # [ 0.463031] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] hub # [ 6.895957] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 0.464031] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] worker # [ 0.465032] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] hub # [ 6.900752] systemd[1]: Mounting FUSE Control File System... worker # [ 0.466031] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] worker # [ 0.467046] pci_bus 0000:00: root bus resource [bus 00-ff] hub # [ 6.902615] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 0.468149] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint worker # [ 0.469821] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint worker # [ 0.473113] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] hub # [ 6.917327] systemd[1]: Starting Journal Service... worker # [ 0.474065] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] worker # [ 0.475085] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] worker # [ 0.476415] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] worker # [ 0.477946] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint hub # [ 6.928416] systemd[1]: Starting Load Kernel Modules... worker # [ 0.481062] pci 0000:00:02.0: BAR 0 [io 0xc180-0xc19f] worker # [ 0.482050] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] worker # [ 0.483086] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] worker # [ 0.484046] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] hub # [ 6.936746] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 0.486383] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.489052] pci 0000:00:03.0: BAR 0 [io 0xc1a0-0xc1bf] worker # [ 0.490050] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] hub # [ 6.946267] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 0.491096] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] worker # [ 0.493428] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.496012] pci 0000:00:04.0: BAR 0 [io 0xc1c0-0xc1df] worker # [ 0.496944] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] hub # [ 6.957304] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 0.498078] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] worker # [ 0.500107] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint worker # [ 0.503047] pci 0000:00:05.0: BAR 0 [io 0xc1e0-0xc1ff] worker # [ 0.504045] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] worker # [ 0.505082] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] hub # [ 6.969255] systemd[1]: Starting Coldplug All udev Devices... worker # [ 0.507180] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint worker # [ 0.510046] pci 0000:00:06.0: BAR 0 [io 0xc000-0xc07f] worker # [ 0.511045] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] worker # [ 0.512080] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] worker # [ 0.514072] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint hub # [ 6.983120] systemd-journald[290]: Collecting audit messages is enabled. worker # [ 0.517032] pci 0000:00:07.0: BAR 0 [io 0xc080-0xc0ff] worker # [ 0.518043] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] worker # [ 0.519079] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] worker # [ 0.521154] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint worker # [ 0.523043] pci 0000:00:08.0: BAR 0 [io 0xc200-0xc21f] worker # [ 0.524043] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] hub # [ 6.996918] systemd[1]: Listening on Journal Log Access Socket. worker # [ 0.525078] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] worker # [ 0.526043] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] worker # [ 0.528102] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint hub # [ 7.002648] systemd[1]: Mounted Huge Pages File System. worker # [ 0.530064] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] worker # [ 0.531080] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] hub # [ 7.007383] loop: module loaded worker # [ 0.533112] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint hub # [ 7.009425] EXT4-fs (vda): re-mounted b308fd1a-0fb6-44f4-9aac-be7e336f83af. worker # [ 0.535673] pci 0000:00:0a.0: BAR 0 [io 0xc100-0xc13f] hub # [ 7.013534] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 0.536042] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] worker # [ 0.537076] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] worker # [ 0.539072] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint worker # [ 0.541042] pci 0000:00:0b.0: BAR 0 [io 0xc220-0xc23f] hub # [ 7.021792] systemd[1]: Mounted Kernel Debug File System. worker # [ 0.542043] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] worker # [ 0.543081] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] worker # [ 0.545563] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.548102] pci 0000:00:1d.0: BAR 4 [io 0xc240-0xc25f] hub # [ 7.030354] systemd[1]: Mounted Kernel Trace File System. worker # [ 0.549386] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint worker # [ 0.550842] pci 0000:00:1d.1: BAR 4 [io 0xc260-0xc27f] worker # [ 0.552529] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint hub # [ 7.038547] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 0.553866] pci 0000:00:1d.2: BAR 4 [io 0xc280-0xc29f] worker # [ 0.555380] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint hub # [ 7.045200] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 0.556824] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] worker # [ 0.558452] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint hub # [ 7.052546] systemd[1]: Finished Load Kernel Module configfs. worker # [ 0.559590] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO hub # [ 6.850105] systemd[1]: Queued start job for default target Multi-User System. worker # [ 0.560449] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint hub # [ 6.851867] systemd[1]: systemd-journald.service: Deactivated successfully. hub # [ 6.853693] systemd-modules-load[291]: Inserted module 'loop' worker # [ 0.563082] pci 0000:00:1f.2: BAR 4 [io 0xc2a0-0xc2bf] hub # [ 7.062632] systemd[1]: Started Journal Service. worker # [ 0.564043] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] hub # [ 6.859353] systemd-modules-load[291]: Inserted module 'tls' worker # [ 0.565606] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint worker # [ 0.567099] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] worker # [ 0.574957] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 worker # [ 0.576173] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 hub # [ 6.872132] systemd[1]: Mounted FUSE Control File System. hub # [ 6.875118] systemd[1]: Finished Load Kernel Modules. worker # [ 0.577215] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 worker # [ 0.578181] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 worker # [ 0.579165] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 worker # [ 0.580157] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 hub # [ 6.880254] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 0.581151] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 worker # [ 0.582135] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 worker # [ 0.583076] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 worker # [ 0.584041] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 worker # [ 0.585044] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 worker # [ 0.586045] ACPI: PCI: Interrupt link GSID configured for IRQ 19 worker # [ 0.587040] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 worker # [ 0.588041] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 worker # [ 0.589043] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 worker # [ 0.590046] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 worker # [ 0.592056] iommu: Default domain type: Translated worker # [ 0.593037] iommu: DMA domain TLB invalidation policy: lazy mode hub # [ 6.898144] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 0.594262] ACPI: bus type USB registered worker # [ 0.595081] usbcore: registered new interface driver usbfs hub # [ 6.901381] systemd[1]: Mounting Kernel Configuration File System... worker # [ 0.596047] usbcore: registered new interface driver hub worker # [ 0.597042] usbcore: registered new device driver usb worker # [ 0.598721] NetLabel: Initializing worker # [ 0.599035] NetLabel: domain hash size = 128 worker # [ 0.600029] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO hub # [ 6.906787] systemd-oomd[292]: No swap; memory pressure usage will be degraded worker # [ 0.601064] NetLabel: unlabeled traffic allowed by default worker # [ 0.602040] PCI: Using ACPI for IRQ routing hub # [ 6.913758] systemd[1]: Starting Firewall... hub # [ 6.924056] systemd[1]: Starting Flush Journal to Persistent Storage... hub # [ 6.925450] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 6.934969] systemd[1]: Starting Load/Save OS Random Seed... hub # [ 6.952217] systemd[1]: Starting Apply Kernel Variables... hub # [ 6.969453] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 6.975896] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 6.978755] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 0.689120] pci 0000:00:01.0: vgaarb: setting as boot VGA device worker # [ 0.690025] pci 0000:00:01.0: vgaarb: bridge control possible worker # [ 0.690025] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none worker # [ 0.690030] vgaarb: loaded worker # [ 0.690917] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 worker # [ 0.691967] hpet0: 3 comparators, 64-bit 100.000000 MHz counter hub # [ 7.212049] systemd-journald[290]: Received client request to flush runtime journal. worker # [ 0.697123] clocksource: Switched to clocksource kvm-clock worker # [ 0.699288] VFS: Disk quotas dquot_6.6.0 worker # [ 0.701739] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) worker # [ 0.703627] pnp: PnP ACPI init worker # [ 0.704622] ACPI: IRQ 4 override to edge(!), high(!) worker # [ 0.705952] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved worker # [ 0.707955] pnp: PnP ACPI: found 6 devices worker # [ 0.715186] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns worker # [ 0.717194] clocksource: Switched to clocksource acpi_pm worker # [ 0.718671] NET: Registered PF_INET protocol family worker # [ 0.720219] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) worker # [ 0.735735] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) worker # [ 0.737878] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) worker # [ 0.739786] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) worker # [ 0.741664] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) worker # [ 0.743399] TCP: Hash tables configured (established 16384 bind 16384) worker # [ 0.745061] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) worker # [ 0.746793] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.748384] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) worker # [ 0.750115] NET: Registered PF_UNIX/PF_LOCAL protocol family worker # [ 0.751453] NET: Registered PF_XDP protocol family worker # [ 0.752658] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] worker # [ 0.754120] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] worker # [ 0.755608] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] worker # [ 0.757187] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] worker # [ 0.758744] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] worker # [ 0.760303] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] worker # [ 0.762417] ACPI: \_SB_.GSIA: Enabled at IRQ 16 worker # [ 0.764517] ACPI: \_SB_.GSIB: Enabled at IRQ 17 worker # [ 0.766452] ACPI: \_SB_.GSIC: Enabled at IRQ 18 worker # [ 0.768393] ACPI: \_SB_.GSID: Enabled at IRQ 19 worker # [ 0.770315] PCI: CLS 0 bytes, default 64 worker # [ 0.771546] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns worker # [ 0.774067] Trying to unpack rootfs image as initramfs... worker # [ 0.812999] Initialise system trusted keyrings worker # [ 0.816634] workingset: timestamp_bits=40 max_order=19 bucket_order=0 worker # [ 0.836938] Key type asymmetric registered worker # [ 0.840602] Asymmetric key parser 'x509' registered worker # [ 0.841853] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) worker # [ 0.848711] io scheduler mq-deadline registered worker # [ 0.849819] io scheduler kyber registered worker # [ 0.853089] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled worker # [ 0.857857] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A worker # [ 0.864448] Linux agpgart interface v0.103 worker # [ 0.865525] ACPI: bus type drm_connector registered worker # [ 0.868948] usbcore: registered new interface driver usbserial_generic worker # [ 0.870456] usbserial: USB Serial support registered for generic worker # [ 0.873598] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled worker # [ 0.875442] drop_monitor: Initializing network drop monitor service worker # [ 0.879754] NET: Registered PF_INET6 protocol family worker # [ 0.884926] Segment Routing with IPv6 hub # [ 7.200440] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 0.888607] In-situ OAM (IOAM) with IPv6 worker # [ 0.889980] IPI shorthand broadcast: enabled hub # [ 7.204100] systemd[1]: Mounted Kernel Configuration File System. hub # [ 7.207088] systemd[1]: Reached target First Boot Complete. worker # [ 0.894881] sched_clock: Marking stable (680024245, 214552871)->(1028999401, -134422285) hub # [ 7.208384] systemd[1]: Finished Apply Kernel Variables. hub # [ 7.210410] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. hub # [ 7.212822] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 0.900783] registered taskstats version 1 worker # [ 0.902063] Loading compiled-in X.509 certificates hub # [ 7.215239] systemd[1]: Finished Create Static Device Nodes in /dev. hub # [ 7.217185] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 7.219765] systemd[1]: Starting Rule-based Manager for Device Events and Files... hub # [ 7.223289] systemd[1]: Finished Flush Journal to Persistent Storage. worker # [ 0.915608] Demotion targets for Node 0: null worker # [ 0.916896] Key type .fscrypt registered hub # [ 7.232817] systemd[1]: Finished Coldplug All udev Devices. worker # [ 0.920586] Key type fscrypt-provisioning registered worker # [ 0.921946] ima: No TPM chip found, activating TPM-bypass! worker # [ 0.924607] ima: Allocated hash algorithm: sha1 worker # [ 0.925783] ima: No architecture policies found worker # [ 0.929767] PM: Magic number: 6:673:326 worker # [ 0.934976] RAS: Correctable Errors collector initialized. worker # [ 0.942403] clk: Disabling unused clocks worker # [ 0.947596] PM: genpd: Disabling unused power domains hub # [ 7.283132] systemd-udevd[330]: Using default interface naming scheme 'v261'. hub # [ 7.365426] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 1.130928] Freeing initrd memory: 29268K worker # [ 1.134866] Freeing unused decrypted memory: 2028K worker # [ 1.137683] Freeing unused kernel image (initmem) memory: 3644K worker # [ 1.139165] Write protecting the kernel read-only data: 32768k worker # [ 1.141306] Freeing unused kernel image (text/rodata gap) memory: 1220K worker # [ 1.143280] Freeing unused kernel image (rodata/data gap) memory: 756K worker # [ 1.177116] x86/mm: Checked W+X mappings: passed, no W+X pages found. worker # [ 1.178814] Run /init as init process worker # [ 1.187901] systemd[1]: Inserted module 'autofs4' worker # [ 1.203963] fuse: init (API version 7.45) worker # [ 1.209827] ACPI: \_SB_.GSIG: Enabled at IRQ 22 worker # [ 1.212856] ACPI: \_SB_.GSIH: Enabled at IRQ 23 worker # [ 1.216490] ACPI: \_SB_.GSIE: Enabled at IRQ 20 hub # [ 7.529591] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 1.219197] ACPI: \_SB_.GSIF: Enabled at IRQ 21 hub # [ 7.551467] systemd[1]: Mounting /run/wrappers... worker # [ 1.249829] systemd[1]: Successfully made /usr/ read-only. hub # [ 7.589911] systemd[1]: Mounted /run/wrappers. hub # [ 7.592102] systemd[1]: Reached target Local File Systems. hub # [ 7.596219] systemd[1]: Listening on Boot Loader Control Service Socket. hub # [ 7.601659] systemd[1]: Starting register-nix-paths.service... hub # [ 7.606676] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 7.607925] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 7.612472] systemd[1]: Starting Save Transient machine-id to Disk... hub # [ 7.627982] systemd[1]: Starting Create System Files and Directories... hub # [ 7.678279] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. hub # [ 7.690834] systemd[1]: Finished Save Transient machine-id to Disk. hub # [ 7.745657] systemd[1]: Finished Create System Files and Directories. hub # [ 7.756153] systemd[1]: Starting Rebuild Journal Catalog... hub # [ 7.765709] systemd[1]: Starting Record System Boot/Shutdown in UTMP... hub # [ 7.769164] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. hub # [ 7.813913] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. hub # [ 7.863918] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 1.586405] systemd[1]: systemd 261.1 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.595032] systemd[1]: Detected virtualization kvm. worker # [ 1.596689] systemd[1]: Detected architecture x86-64. worker # [ 1.598221] systemd[1]: Running in initrd. worker # [ 1.599677] systemd[1]: Initializing machine ID from random generator. worker # [ 1.601364] systemd[1]: Hostname set to . hub # [ 7.918235] systemd[1]: Finished Rebuild Journal Catalog. hub # [ 7.927646] (udev-worker)[388]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. hub # [ 7.933183] systemd[1]: Starting Update is Completed... hub # [ 7.935730] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line. hub # [ 7.949580] (udev-worker)[377]: Network interface NamePolicy= disabled on kernel command line. hub # [ 7.990439] systemd[1]: Finished Update is Completed. hub # [ 8.066698] systemd[1]: Finished Firewall. worker # [ 1.773023] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 1.812240] systemd[1]: Queued start job for default target Initrd Default Target. worker # [ 1.816843] systemd[1]: Created slice Slice /system/modprobe. worker # [ 1.818656] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 1.820917] systemd[1]: Expecting device /dev/disk/by-label/nix-store... worker # [ 1.823062] systemd[1]: Expecting device /dev/disk/by-label/nixos... worker # [ 1.825027] systemd[1]: Reached target Path Units. worker # [ 1.826667] systemd[1]: Reached target Slice Units. worker # [ 1.828399] systemd[1]: Reached target Swaps. worker # [ 1.829752] systemd[1]: Reached target Timer Units. worker # [ 1.832107] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 1.833956] systemd[1]: Listening on Journal Socket (/dev/log). worker # [ 1.835653] systemd[1]: Listening on Journal Sockets. worker # [ 1.837094] systemd[1]: Listening on udev Control Socket. hub # [ 8.150150] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 1.838611] systemd[1]: Listening on udev Kernel Socket. worker # [ 1.840082] systemd[1]: Reached target Socket Units. hub # [ 8.153426] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 1.842441] systemd[1]: Starting Create List of Static Device Nodes... hub # [ 8.159117] systemd[1]: Condition check resulted in Virtio network device being skipped. hub # [ 8.160745] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 1.848376] systemd[1]: Starting Load Kernel Module 9pnet_virtio... hub # [ 8.165876] systemd[1]: Starting Create SUID/SGID Wrappers... hub # [ 8.167361] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. hub # [ 8.172194] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 1.861205] systemd[1]: Starting Load Kernel Module configfs... hub # [ 8.176305] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore hub # [ 8.178419] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os hub # [ 8.180112] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.872780] systemd[1]: Starting Journal Service... worker # [ 1.889673] systemd[1]: Starting Load Kernel Modules... worker # [ 1.893524] netfs: FS-Cache loaded worker # [ 1.896776] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 1.907034] systemd[1]: Starting Coldplug All udev Devices... worker # [ 1.912780] 9pnet: Installing 9P2000 support worker # [ 1.929963] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 1.935111] systemd-journald[67]: Collecting audit messages is disabled. worker # [ 1.939372] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. worker # [ 1.961330] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. worker # [ 1.967162] systemd[1]: Finished Load Kernel Module 9pnet_virtio. worker # [ 1.973711] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev worker # [ 1.976423] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 1.983636] systemd[1]: Finished Load Kernel Module configfs. worker # [ 1.991317] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config hub # [ 8.524079] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 2.007638] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... hub # [ 8.532129] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 2.022958] systemd[1]: Finished Load Kernel Modules. worker # [ 2.032863] systemd[1]: Starting Apply Kernel Variables... worker # [ 2.048016] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 2.062948] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 2.078762] systemd[1]: Finished Apply Kernel Variables. worker # [ 2.094775] systemd[1]: Started Journal Service. worker # [ 1.881626] systemd-modules-load[68]: Inserted module 'dm_mod' worker # [ 1.884353] systemd-modules-load[68]: Inserted module 'virtio_balloon' worker # [ 1.887374] systemd-modules-load[68]: Inserted module 'virtio_gpu' worker # [ 1.892334] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 1.898934] systemd[1]: Reached target Preparation for Local File Systems. hub # [ 8.593763] ACPI: button: Power Button [PWRF] worker # [ 1.903088] systemd[1]: Reached target Local File Systems. worker # [ 1.905089] systemd[1]: Starting Create System Files and Directories... worker # [ 1.910681] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 1.934844] systemd[1]: Finished Create System Files and Directories. worker # [ 1.942835] systemd[1]: Finished Coldplug All udev Devices. hub # [ 8.615462] mousedev: PS/2 mouse device common for all mice worker # [ 1.950953] systemd-udevd[84]: Using default interface naming scheme 'v261'. hub # [ 8.491582] systemd[1]: Finished register-nix-paths.service. worker # [ 1.966099] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 1.967869] systemd[1]: Reached target System Initialization. worker # [ 1.970551] systemd[1]: Reached target Basic System. hub # [ 8.633809] Console: switching to colour dummy device 80x25 hub # [ 8.705878] [drm] Found bochs VGA, ID 0xb0c5. hub # [ 8.705880] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. hub # [ 8.718365] rtc_cmos 00:04: RTC can wake from S4 hub # [ 8.719865] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic hub # [ 8.739115] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized hub # [ 8.745816] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 hub # [ 8.747678] rtc_cmos 00:04: registered as rtc0 hub # [ 8.748459] rtc_cmos 00:04: setting system clock to 2026-08-31T10:18:15 UTC (1788171495) hub # [ 8.749959] systemd-journald[290]: Time jumped backwards, rotating. hub # [ 8.752094] parport_pc 00:02: reported by Plug and Play ACPI hub # [ 8.758895] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 hub # [ 8.775114] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] hub # [ 8.784139] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs hub # [ 8.615977] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. hub # [ 8.618147] systemd[1]: Finished Create SUID/SGID Wrappers. hub # [ 8.620393] systemd[1]: Reached target System Initialization. hub # [ 8.623109] systemd[1]: Started Discard unused filesystem blocks once a week. hub # [ 8.626192] systemd[1]: Started Daily Cleanup of Temporary Directories. hub # [ 8.627489] systemd[1]: Reached target Timer Units. hub # [ 8.628617] systemd[1]: Listening on D-Bus System Message Bus Socket. hub # [ 8.631140] systemd[1]: Listening on Nix Daemon Socket. hub # [ 8.633194] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. hub # [ 8.634883] systemd[1]: Reached target Socket Units. hub # [ 8.636112] systemd[1]: Reached target Basic System. hub # [ 8.638412] systemd[1]: Started backdoor.service. hub # [ 8.643954] systemd[1]: Starting Import lastlog data into lastlog2 database... hub # [ 8.649091] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 8.660361] systemd[1]: Starting Post-Boot Actions... hub # [ 8.678346] systemd[1]: Started Reset console on configuration changes. hub # [ 8.698093] systemd[1]: Starting resolvconf update... hub # connecting to host... worker # [ 2.421644] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 hub # [ 8.743375] nsncd[588]: Aug 31 10:18:15.697 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 2.436095] virtio_blk virtio4: 1/0/0 default/read/poll queues hub # [ 8.751163] systemd[1]: Finished Post-Boot Actions. hub # [ 8.757783] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 2.455939] serio: i8042 KBD port at 0x60,0x64 irq 1 hub: Guest shell says: b'Spawning backdoor root shell...\n' worker # [ 2.462690] virtio_blk virtio4: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) hub: connected to guest root shell worker # [ 2.470618] serio: i8042 AUX port at 0x60,0x64 irq 12 hub # [ 8.774810] systemd[1]: Reached target Host and Network Name Lookups. hub: (connecting took 3.11 seconds) hub # [ 8.777099] systemd[1]: Reached target User and Group Name Lookups. hub: (finished: waiting for the VM to finish booting, in 3.11 seconds) hub # [ 8.783228] systemd[1]: Starting D-Bus System Message Bus... worker # [ 2.476398] ehci-pci 0000:00:1d.7: EHCI Host Controller worker # [ 2.477467] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 worker # [ 2.480865] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 worker # [ 2.489605] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 worker # [ 2.491513] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 worker # [ 2.495010] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 hub # [ 8.808482] systemd[1]: Starting User Login Management... worker # [ 2.498118] usb usb1: Product: EHCI Host Controller worker # [ 2.499897] usb usb1: Manufacturer: Linux 6.18.44 ehci_hcd worker # [ 2.502668] usb usb1: SerialNumber: 0000:00:1d.7 worker # [ 2.504434] hub 1-0:1.0: USB hub found worker # [ 2.505740] hub 1-0:1.0: 6 ports detected hub # [ 8.819254] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 2.509125] virtio_blk virtio5: 1/0/0 default/read/poll queues worker # [ 2.510310] uhci_hcd 0000:00:1d.0: UHCI Host Controller worker # [ 2.511288] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 worker # [ 2.524835] virtio_blk virtio5: [vdb] 2102680 512-byte logical blocks (1.08 GB/1.00 GiB) worker # [ 2.527867] uhci_hcd 0000:00:1d.0: detected 2 ports worker # [ 2.538923] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c240 worker # [ 2.553690] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.555231] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.352955] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.358078] systemd[1]: Starting Virtual Console Setup... worker # [ 2.367544] (udev-worker)[102]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 2.370449] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line. worker # [ 2.597650] SCSI subsystem initialized worker # [ 2.604654] usb usb2: Product: UHCI Host Controller worker # [ 2.396662] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 8.925618] dbus-broker-launch[612]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 2.619573] usb usb2: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 2.407120] systemd[1]: Finished Virtual Console Setup. worker # [ 2.631868] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 worker # [ 2.635683] usb usb2: SerialNumber: 0000:00:1d.0 hub # [ 8.948503] dbus-broker-launch[612]: NSS returned no entry for 'systemd-timesync' hub # [ 8.951196] dbus-broker-launch[612]: Invalid user-name in /nix/store/kzpng0c6slx1ybsqg19z01hjm1b6cs5s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 2.645673] hub 2-0:1.0: USB hub found worker # [ 2.650851] hub 2-0:1.0: 2 ports detected worker # [ 2.662599] uhci_hcd 0000:00:1d.1: UHCI Host Controller hub # [ 8.974909] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 2.663595] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 hub # [ 8.976377] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 8.978824] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 2.452082] systemd[1]: Found device /dev/disk/by-label/nix-store. hub # [ 8.982150] systemd[1]: Stopping User and Group Name Lookups... worker # [ 2.457482] systemd[1]: Found device /dev/disk/by-label/nixos. hub # [ 8.985093] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 2.459087] systemd[1]: Reached target Initrd Root Device. hub # [ 8.986482] systemd[1]: Started D-Bus System Message Bus. worker # [ 2.464093] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... worker # [ 2.681618] uhci_hcd 0000:00:1d.1: detected 2 ports worker # [ 2.683279] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c260 hub # [ 9.000917] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 2.690607] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.692134] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.698601] usb usb3: Product: UHCI Host Controller worker # [ 2.700598] usb usb3: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 2.703610] usb usb3: SerialNumber: 0000:00:1d.1 worker # [ 2.495318] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks worker # [ 2.501656] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. worker # [ 2.717877] hub 3-0:1.0: USB hub found hub # [ 9.001022] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 2.720249] hub 3-0:1.0: 2 ports detected worker # [ 2.726204] uhci_hcd 0000:00:1d.2: UHCI Host Controller worker # [ 2.733486] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 worker # [ 2.736380] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode worker # [ 2.738379] uhci_hcd 0000:00:1d.2: detected 2 ports worker # [ 2.740201] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c280 worker # [ 2.742104] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) worker # [ 2.743920] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 worker # [ 2.745682] ahci 0000:00:1f.2: flags: 64bit ncq only worker # [ 2.747368] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 worker # [ 2.748985] usb 1-1: new high-speed USB device number 2 using ehci-pci hub # [ 9.120093] Console: switching to colour frame buffer device 160x50 worker # [ 2.757575] usb usb4: Product: UHCI Host Controller worker # [ 2.759611] scsi host0: ahci worker # [ 2.761974] usb usb4: Manufacturer: Linux 6.18.44 uhci_hcd worker # [ 2.764739] scsi host1: ahci worker # [ 2.766581] usb usb4: SerialNumber: 0000:00:1d.2 worker # [ 2.767951] scsi host2: ahci worker # [ 2.769995] scsi host3: ahci worker # [ 2.771171] hub 4-0:1.0: USB hub found worker # [ 2.773503] scsi host4: ahci worker # [ 2.775092] hub 4-0:1.0: 2 ports detected worker # [ 2.776622] scsi host5: ahci hub # [ 9.202085] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 2.777393] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 worker # [ 2.788587] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 worker # [ 2.796023] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 worker # [ 2.802339] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 worker # [ 2.804232] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 worker # [ 2.806044] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 hub # [ 9.202408] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 2.879673] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 worker # [ 2.881429] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 worker # [ 2.883510] usb 1-1: Product: QEMU USB Tablet worker # [ 2.884731] usb 1-1: Manufacturer: QEMU worker # [ 2.885818] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 worker # [ 2.900284] hid: raw HID events driver (C) Jiri Kosina hub # [ 9.439058] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 2.708989] systemd[1]: Mounting /sysroot... hub # [ 9.016964] dbus-broker-launch[612]: Ready hub # [ 9.242965] systemd[1]: nscd.service: Deactivated successfully. hub # [ 9.249915] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 9.254573] nsncd[681]: Aug 31 10:18:16.029 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 9.261242] network-addresses-eth1-start[687]: adding address 192.168.1.1/24... done hub # [ 9.263722] network-addresses-eth1-start[687]: adding address 2001:db8:1::1/64... done hub # [ 9.269433] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 9.270915] systemd[1]: Finished resolvconf update. hub # [ 9.275212] systemd[1]: Reached target Preparation for Network. hub # [ 9.277775] systemd[1]: Starting DHCP Client... hub # [ 9.281300] systemd[1]: Starting Address configuration of eth1... hub # [ 9.283814] systemd[1]: Starting Extra networking commands.... hub # [ 9.286646] systemd[1]: Starting Virtual Console Setup... hub # [ 9.290058] systemd[1]: Starting Tailscale node agent... hub # [ 9.291416] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 9.294978] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 9.297575] systemd[1]: Reached target User and Group Name Lookups. hub # [ 9.302189] systemd[1]: Finished Address configuration of eth1. hub # [ 9.305537] systemd-logind[616]: New seat seat0. hub # [ 9.311468] systemd-logind[616]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 9.313910] systemd[1]: Started User Login Management. hub # [ 9.319262] systemd[1]: Starting linger-users.service... hub # [ 9.332548] systemd-logind[616]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) hub # [ 9.348148] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 9.359214] systemd[1]: Stopped Virtual Console Setup. hub # [ 9.575974] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub # [ 9.391193] systemd[1]: Starting Virtual Console Setup... hub # [ 9.403809] systemd[1]: linger-users.service: Deactivated successfully. hub # [ 9.409424] systemd[1]: Finished linger-users.service. worker # [ 3.114733] ata2: SATA link down (SStatus 0 SControl 300) hub # [ 9.428121] systemd[1]: Finished Extra networking commands.. worker # [ 3.116114] ata6: SATA link down (SStatus 0 SControl 300) worker # [ 3.117653] ata5: SATA link down (SStatus 0 SControl 300) worker # [ 3.118921] ata4: SATA link down (SStatus 0 SControl 300) worker # [ 3.120278] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) worker # [ 3.121603] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 worker # [ 3.122630] ata3.00: applying bridge limits worker # [ 3.123632] ata1: SATA link down (SStatus 0 SControl 300) worker # [ 3.125000] ata3.00: configured for UDMA/100 worker # [ 3.126355] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 hub # [ 9.439507] systemd[1]: Reached target Network. hub # [ 9.449121] systemd[1]: Starting Nginx Web Server... hub # [ 9.461731] systemd[1]: Starting Permit User Sessions... worker # [ 3.179299] usbcore: registered new interface driver usbhid hub # [ 9.700977] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 3.183817] usbhid: USB HID core driver hub # [ 9.720370] ppdev: user-space parallel port driver worker # [ 3.207251] 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.215788] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 worker # [ 3.221427] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray worker # [ 3.227202] EXT4-fs (vda): mounted filesystem af339342-6900-4166-a2fd-1b2b716286e2 r/w with ordered data mode. Quota mode: none. hub # [ 9.544203] systemd[1]: Finished Permit User Sessions. worker # [ 3.019259] systemd[1]: Mounted /sysroot. worker # [ 3.022084] systemd[1]: Reached target Initrd Root File System. worker # [ 3.237823] cdrom: Uniform CD-ROM driver Revision: 3.20 worker # [ 3.026103] systemd[1]: Starting Mountpoints Configured in the Real Root... hub # [ 9.561185] systemd[1]: Started Getty on tty1. hub # [ 9.566218] systemd[1]: Reached target Login Prompts. worker # [ 3.043317] systemd-sysroot-fstab-check[145]: /sysroot should be mounted in the initrd, will request daemon-reload. worker # [ 3.049313] systemd[1]: Reload requested from client PID 145 ('systemd-sysroot') (unit initrd-parse-etc.service)... worker # [ 3.051471] systemd[1]: Reloading... hub # [ 9.605036] systemd-logind[616]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) hub # [ 9.614395] dhcpcd[727]: dhcpcd-10.3.2 starting hub # [ 9.621848] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. hub # [ 9.626801] systemd[1]: Stopped Virtual Console Setup. hub # [ 9.632728] dhcpcd[787]: dev: loaded udev hub # [ 9.641887] tailscaled[701]: TPM: error opening: stat /dev/tpmrm0: no such file or directory hub # [ 9.667297] systemd[1]: Starting Virtual Console Setup... worker # [ 3.158948] systemd[1]: Reloading finished in 109 ms. hub # [ 9.895704] 8021q: 802.1Q VLAN Support v1.8 worker # [ 3.165494] systemd-sysroot-fstab-check[145]: Requesting initrd-fs.target/start/replace... hub # [ 9.901150] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 3.170364] systemd-sysroot-fstab-check[145]: Requesting swap.target/start/replace... worker # [ 3.174742] systemd[1]: initrd-parse-etc.service: Deactivated successfully. worker # [ 3.176803] systemd[1]: Finished Mountpoints Configured in the Real Root. worker # [ 3.179249] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. worker # [ 3.181991] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio hub # [ 9.710643] tailscaled[701]: Program starting: v1.102.2, Go 1.26.5: []string{"/nix/store/ilmsaffab3j7a5y17yrfgng1dm111wk1-tailscale-1.102.2/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} hub # [ 9.718094] tailscaled[701]: LogID: 7618311e817bc76edacf84f9bd84b514523f98d894042b310c5b8f9fb5fd3bac hub # [ 9.719923] tailscaled[701]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 9.721399] tailscaled[701]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory hub # [ 9.723937] tailscaled[701]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil hub # [ 9.775687] dbus-broker-launch[612]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. hub # [ 9.791897] tailscaled[701]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:51059->[::1]:53: read: connection refused (in 33ms), trying bootstrap... hub # [ 9.822398] tailscaled[701]: trying bootstrapDNS("derp4e.tailscale.com", "134.122.74.153") for "log.tailscale.com" ... hub # [ 9.832931] tailscaled[701]: 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 # [ 9.840257] tailscaled[701]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... hub # [ 9.844130] tailscaled[701]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable hub # [ 9.852847] tailscaled[701]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... hub # [ 9.855399] tailscaled[701]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable hub # [ 9.872155] tailscaled[701]: trying bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" ... hub # [ 9.898419] tailscaled[701]: bootstrapDNS("derp2e.tailscale.com", "2607:f740:0:3f::44c") for "log.tailscale.com" error: Get "https://derp2e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::44c]:443: connect: network is unreachable hub # [ 9.902587] tailscaled[701]: trying bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" ... hub # [ 9.908171] tailscaled[701]: bootstrapDNS("derp6.tailscale.com", "68.183.90.120") for "log.tailscale.com" error: Get "https://derp6.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 68.183.90.120:443: connect: network is unreachable hub # [ 9.917371] tailscaled[701]: trying bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" ... hub # [ 9.919327] tailscaled[701]: bootstrapDNS("derp1e.tailscale.com", "2604:a880:800:10::873:4001") for "log.tailscale.com" error: Get "https://derp1e.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::873:4001]:443: connect: network is unreachable hub # [ 9.934843] tailscaled[701]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ... hub # [ 9.943230] tailscaled[701]: bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 18.230.97.74:443: connect: network is unreachable hub # [ 9.947788] tailscaled[701]: trying bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" ... hub # [ 9.954922] tailscaled[701]: bootstrapDNS("derp3.tailscale.com", "2400:6180:0:d1::67d:8001") for "log.tailscale.com" error: Get "https://derp3.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2400:6180:0:d1::67d:8001]:443: connect: network is unreachable hub # [ 9.959430] tailscaled[701]: trying bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" ... hub # [ 9.966113] tailscaled[701]: bootstrapDNS("derp5.tailscale.com", "103.43.75.49") for "log.tailscale.com" error: Get "https://derp5.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 103.43.75.49:443: connect: network is unreachable hub # [ 9.970760] tailscaled[701]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... hub # [ 9.974103] tailscaled[701]: 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 # [ 9.981206] tailscaled[701]: trying bootstrapDNS("derp1e.tailscale.com", "64.225.56.166") for "log.tailscale.com" ... hub # [ 9.993329] tailscaled[701]: 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 # [ 9.997503] tailscaled[701]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ... hub # [ 10.010856] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. hub # [ 10.013102] tailscaled[701]: bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::287]:443: connect: network is unreachable hub # [ 10.019133] tailscaled[701]: logtail: upload: log upload of 466 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/287981012f7e8f4e5bbc4617a1cbee3075641512f99ba7c69a05e8ee8c4be960": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" hub # [ 10.026472] tailscaled[701]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 10.028946] tailscaled[701]: dns: using "openresolv" mode hub # [ 10.038201] tailscaled[701]: dns: using dns.openresolvManager hub # [ 10.336060] cfg80211: Loading compiled-in X.509 certificates for regulatory database hub # [ 10.151396] nginx-pre-start[792]: nginx: the configuration file /nix/store/1kl4pzh0gmrqd9lzh73awmy65bj51nmn-nginx.conf syntax is ok hub # [ 10.159148] nginx-pre-start[792]: nginx: configuration file /nix/store/1kl4pzh0gmrqd9lzh73awmy65bj51nmn-nginx.conf test is successful hub # [ 10.174607] systemd[1]: Started Nginx Web Server. hub # [ 10.383988] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' hub # [ 10.384880] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' hub # [ 10.391596] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 hub # [ 10.392809] cfg80211: failed to load regulatory.db worker # [ 3.710700] systemd[1]: Mounting /sysroot/nix/.ro-store... worker # [ 3.714972] systemd[1]: Mounting /sysroot/nix/.rw-store... worker # [ 3.719867] systemd[1]: Mounting /sysroot/run... worker # [ 3.723237] systemd[1]: Mounting /sysroot/tmp/shared... worker # [ 3.728909] systemd[1]: Mounting /sysroot/tmp/xchg... hub # [ 10.270296] systemd-vconsole-setup[789]: Configuration of first virtual console was skipped, ignoring remaining ones. hub # [ 10.279326] systemd[1]: Finished Virtual Console Setup. worker # [ 3.754482] systemd[1]: Mounted /sysroot/nix/.rw-store. worker # [ 3.971158] erofs (device vdb): mounted with root inode @ nid 36. worker # [ 3.763107] systemd[1]: Mounted /sysroot/run. worker # [ 3.767186] systemd[1]: Mounted /sysroot/nix/.ro-store. worker # [ 3.986097] 9p: Installing v9fs 9p2000 file system support worker # [ 3.775805] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 3.783896] systemd[1]: Mounted /sysroot/tmp/shared. worker # [ 3.786278] systemd[1]: Mounted /sysroot/tmp/xchg. worker # [ 3.794335] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 3.796785] systemd[1]: Finished rw-sysroot-nix-store.service. hub # [ 10.547134] 8021q: adding VLAN 0 to HW filter on device eth0 hub # [ 10.347173] dhcpcd[787]: eth0: waiting for carrier hub # [ 10.350134] dhcpcd[787]: libudev: received NULL device hub # [ 10.351832] dhcpcd[787]: libudev: received NULL device hub # [ 10.354176] dhcpcd[787]: eth0: carrier acquired hub # [ 10.371309] dhcpcd[787]: DUID 00:01:00:01:32:28:11:69:52:54:00:12:34:56 hub # [ 10.373330] dhcpcd[787]: eth0: IAID 00:12:34:56 hub # [ 10.376141] dhcpcd[787]: eth0: adding address fe80::5054:ff:fe12:3456 hub # [ 10.584237] kvm_amd: TSC scaling supported hub # [ 10.584865] kvm_amd: Nested Virtualization enabled hub # [ 10.590100] kvm_amd: Nested Paging enabled hub # [ 10.593554] kvm_amd: LBR virtualization supported hub # [ 10.596266] kvm_amd: Virtual VMLOAD VMSAVE supported hub # [ 10.597048] kvm_amd: Virtual GIF supported hub # [ 10.633490] EDAC MC: Ver: 3.0.0 hub # [ 10.452679] tailscaled[701]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found hub # [ 10.458778] systemd[1]: Started Tailscale node agent. hub # [ 10.460889] tailscaled[701]: wgengine.NewUserspaceEngine(tun "tailscale0") ... hub # [ 10.680840] tun: Universal TUN/TAP device driver, 1.6 hub # [ 10.482555] (udev-worker)[850]: Network interface NamePolicy= disabled on kernel command line. hub # [ 10.509849] tailscaled[701]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] hub # [ 10.511777] tailscaled[701]: dns: using "openresolv" mode hub # [ 10.517424] tailscaled[701]: dns: using dns.openresolvManager hub # [ 10.518986] tailscaled[701]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.1/24 2001:db8:1::1/64 llu6]} v4=true v6=true} hub # [ 10.527218] tailscaled[701]: magicsock: disco key = d:1635487da4e53fa1 hub # [ 10.528816] tailscaled[701]: Creating WireGuard device... hub # [ 10.531282] tailscaled[701]: Bringing WireGuard device up... hub # [ 10.533389] tailscaled[701]: Bringing router up... hub # [ 10.534650] tailscaled[701]: router: using firewall mode pref hub # [ 10.543388] tailscaled[701]: router: portUpdate(port=41641, network=udp6) hub # [ 10.549611] tailscaled[701]: external route: up hub # [ 10.562104] tailscaled[701]: router: default choosing iptables hub # [ 10.584312] tailscaled[701]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true hub # [ 10.588782] tailscaled[701]: Clearing router settings... hub # [ 10.590230] tailscaled[701]: Starting network monitor... hub # [ 10.592639] tailscaled[701]: Engine created. hub # [ 10.599092] tailscaled[701]: router: portUpdate(port=41641, network=udp4) hub # [ 10.605987] tailscaled[701]: pm: migrating "_daemon" profile to new format hub # [ 10.607580] tailscaled[701]: envknob: PORT="41641" hub # [ 10.612174] tailscaled[701]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" hub # [ 10.613927] tailscaled[701]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes hub # [ 10.617625] tailscaled[701]: got LocalBackend in 157ms hub # [ 10.618813] tailscaled[701]: Start hub # [ 10.620064] tailscaled[701]: ipnext: "conn25": skipping extension hub # [ 10.621515] tailscaled[701]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop hub # [ 10.626083] tailscaled[701]: profile data directory: profile not found hub # [ 10.628337] tailscaled[701]: Backend: logs: be:7618311e817bc76edacf84f9bd84b514523f98d894042b310c5b8f9fb5fd3bac fe: hub # [ 10.630606] tailscaled[701]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) hub # [ 10.632520] tailscaled[701]: blockEngineUpdates(true) hub # [ 10.634805] tailscaled[701]: health(warnable=wantrunning-false): error: Tailscale is stopped. hub # [ 10.637080] tailscaled[701]: wgengine: Reconfig: configuring router hub # [ 10.638542] tailscaled[701]: wgengine: Reconfig: user dialer hub # [ 10.639635] tailscaled[701]: wgengine: Reconfig: configuring DNS hub # [ 10.641266] tailscaled[701]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 10.643082] tailscaled[701]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 10.644467] tailscaled[701]: dns: OScfg: {} hub # [ 10.955698] dhcpcd[787]: eth0: soliciting a DHCP lease hub # [ 11.172582] NET: Registered PF_PACKET protocol family hub # [ 10.972509] dhcpcd[787]: eth0: offered 10.0.2.15 from 10.0.2.2 hub # [ 10.974229] dhcpcd[787]: eth0: probing address 10.0.2.15/24 worker # [ 4.709818] systemd[1]: Mounting /sysroot/nix/store... worker # [ 4.729717] systemd[1]: Mounted /sysroot/nix/store. worker # [ 4.731875] systemd[1]: Reached target Initrd File Systems. worker # [ 4.734283] systemd[1]: Starting Find NixOS closure... worker # [ 4.738420] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... worker # [ 4.754482] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. worker # [ 4.757986] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. worker # [ 4.764622] systemd[1]: Finished Find NixOS closure. worker # [ 4.766981] systemd[1]: Reached target Initrd Default Target. worker # [ 4.768432] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... worker # [ 4.784491] systemd[1]: Stopped target Initrd Default Target. worker # [ 4.786279] systemd[1]: Stopped target Basic System. worker # [ 4.788192] systemd[1]: Stopped target Initrd Root Device. worker # [ 4.789387] systemd[1]: Stopped target Path Units. worker # [ 4.790900] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. worker # [ 4.793297] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. worker # [ 4.795333] systemd[1]: Stopped target Slice Units. worker # [ 4.797201] systemd[1]: Stopped target Socket Units. worker # [ 4.798363] systemd[1]: Stopped target System Initialization. worker # [ 4.799546] systemd[1]: Stopped target Swaps. worker # [ 4.800981] systemd[1]: Stopped target Timer Units. worker # [ 4.803096] systemd[1]: dbus.socket: Deactivated successfully. worker # [ 4.804370] systemd[1]: Closed D-Bus System Message Bus Socket. worker # [ 4.805595] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. worker # [ 4.807411] systemd[1]: Stopped Find NixOS closure. worker # [ 4.809181] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 4.811442] systemd[1]: Starting rw-sysroot-nix-store.service... worker # [ 4.812861] systemd[1]: systemd-sysctl.service: Deactivated successfully. worker # [ 4.815237] systemd[1]: Stopped Apply Kernel Variables. worker # [ 4.816492] systemd[1]: systemd-modules-load.service: Deactivated successfully. worker # [ 4.817984] systemd[1]: Stopped Load Kernel Modules. worker # [ 4.820177] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. worker # [ 4.821681] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. worker # [ 4.823174] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. worker # [ 4.824763] systemd[1]: Stopped Create System Files and Directories. worker # [ 4.826445] systemd[1]: Stopped target Local File Systems. worker # [ 4.828001] systemd[1]: Stopped target Preparation for Local File Systems. worker # [ 4.830560] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. worker # [ 4.834206] systemd[1]: Stopped Coldplug All udev Devices. worker # [ 4.835390] systemd[1]: Stopping Rule-based Manager for Device Events and Files... worker # [ 4.836965] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 4.840359] systemd[1]: Stopped Virtual Console Setup. worker # [ 4.848756] systemd[1]: initrd-cleanup.service: Deactivated successfully. worker # [ 4.851421] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. worker # [ 4.854468] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. worker # [ 4.857114] systemd[1]: Finished rw-sysroot-nix-store.service. worker # [ 4.859423] systemd[1]: systemd-udevd.service: Deactivated successfully. worker # [ 4.861433] systemd[1]: Stopped Rule-based Manager for Device Events and Files. worker # [ 4.866126] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. worker # [ 4.867655] systemd[1]: Closed udev Control Socket. worker # [ 4.870093] systemd[1]: Starting Cleanup udev Database... worker # [ 4.871213] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. worker # [ 4.872668] systemd[1]: Stopped Create Static Device Nodes in /dev. worker # [ 4.874218] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. worker # [ 4.876191] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. worker # [ 4.877921] systemd[1]: kmod-static-nodes.service: Deactivated successfully. worker # [ 4.879316] systemd[1]: Stopped Create List of Static Device Nodes. worker # [ 4.892414] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. worker # [ 4.895092] systemd[1]: Finished Cleanup udev Database. worker # [ 4.896419] systemd[1]: Reached target Switch Root. worker # [ 4.898465] systemd[1]: Starting NixOS Activation... worker # [ 4.948981] initrd-nixos-activation-start[200]: booting system configuration /nix/store/iadhhf74gclqsnjqdw08h77n0g84mcf9-nixos-system-worker-test worker # [ 4.965496] initrd-nixos-activation-start[200]: running activation script... worker # [ 5.088838] initrd-nixos-activation-start[223]: setting up /etc... worker # [ 5.152088] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. worker # [ 5.153798] systemd[1]: Finished NixOS Activation. worker # [ 5.156740] systemd[1]: Starting Switch Root... worker # [ 5.169212] systemd[1]: Switching root. worker # [ 5.511582] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). worker # [ 5.565244] NET: Registered PF_VSOCK protocol family worker # [ 5.915122] systemd[1]: systemd 261.1 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.921139] systemd[1]: Detected virtualization kvm. worker # [ 5.922304] systemd[1]: Detected architecture x86-64. worker # [ 5.923407] systemd[1]: Detected first boot. worker # [ 5.924669] systemd[1]: Initializing machine ID from random generator. worker # [ 6.108960] systemd[1]: bpf-restrict-fs: LSM BPF program attached worker # [ 6.201574] systemd[1]: Applying preset policy. worker # [ 6.259105] systemd[1]: Populated /etc with preset unit settings. worker # [ 6.348772] systemd[1]: initrd-switch-root.service: Deactivated successfully. worker # [ 6.350794] systemd[1]: Stopped initrd-switch-root.service. worker # [ 6.353774] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. worker # [ 6.356352] systemd[1]: Created slice Slice /system/getty. worker # [ 6.358055] systemd[1]: Created slice Slice /system/tribuchet-agent. worker # [ 6.359813] systemd[1]: Created slice User and Session Slice. worker # [ 6.361051] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. worker # [ 6.362660] systemd[1]: Started Forward Password Requests to Wall Directory Watch. worker # [ 6.364115] systemd[1]: Expecting device /dev/hvc0... worker # [ 6.365140] systemd[1]: Expecting device /dev/ttyS0... worker # [ 6.366204] systemd[1]: Reached target Local Encrypted Volumes. worker # [ 6.367332] systemd[1]: Stopped target initrd-fs.target. worker # [ 6.368370] systemd[1]: Stopped target initrd-root-fs.target. worker # [ 6.369470] systemd[1]: Stopped target initrd-switch-root.target. worker # [ 6.370679] systemd[1]: Reached target Virtual Machines and Containers. worker # [ 6.371930] systemd[1]: Reached target Path Units. worker # [ 6.372938] systemd[1]: Reached target Remote File Systems. worker # [ 6.374052] systemd[1]: Reached target Slice Units. worker # [ 6.375068] systemd[1]: Reached target Swaps. worker # [ 6.377004] systemd[1]: Listening on Query the User Interactively for a Password. worker # [ 6.383857] systemd[1]: Listening on Process Core Dump Socket. worker # [ 6.385644] systemd[1]: Listening on Credential Encryption/Decryption. worker # [ 6.387685] systemd[1]: Listening on Factory Reset Management. worker # [ 6.388926] systemd[1]: Listening on Hostname Service Socket. worker # [ 6.391861] systemd[1]: Starting Journal Log Access Socket... worker # [ 6.393291] systemd[1]: Listening on Journal Audit Socket. worker # [ 6.396284] systemd[1]: Listening on Console Output Muting Service Socket. worker # [ 6.397764] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. worker # [ 6.399237] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.400957] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki worker # [ 6.404012] systemd[1]: Listening on Disk Repartitioning Service Socket. worker # [ 6.405401] systemd[1]: Listening on udev Control Socket. worker # [ 6.406727] systemd[1]: Listening on udev Varlink Socket. worker # [ 6.409463] systemd[1]: Mounting Huge Pages File System... worker # [ 6.415611] systemd[1]: Mounting POSIX Message Queue File System... worker # [ 6.421613] systemd[1]: Mounting Kernel Debug File System... worker # [ 6.430596] systemd[1]: Mounting Kernel Trace File System... worker # [ 6.445652] systemd[1]: Starting Create List of Static Device Nodes... worker # [ 6.452582] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio worker # [ 6.464646] systemd[1]: Starting Load Kernel Module configfs... worker # [ 6.466634] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm worker # [ 6.470670] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 6.473764] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 6.480614] systemd[1]: Mounting FUSE Control File System... worker # [ 6.483632] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 6.496609] systemd[1]: Starting Journal Service... worker # [ 6.501590] systemd[1]: Starting Load Kernel Modules... worker # [ 6.508593] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... worker # [ 6.516591] systemd[1]: Starting Remount Root and Kernel File Systems... worker # [ 6.519214] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.525592] systemd[1]: Starting Coldplug All udev Devices... worker # [ 6.531545] systemd[1]: Listening on Journal Log Access Socket. worker # [ 6.533708] systemd[1]: Mounted Huge Pages File System. worker # [ 6.536742] systemd[1]: Mounted POSIX Message Queue File System. worker # [ 6.538710] systemd[1]: Mounted Kernel Debug File System. worker # [ 6.541711] systemd[1]: Mounted Kernel Trace File System. worker # [ 6.545595] systemd[1]: Finished Create List of Static Device Nodes. worker # [ 6.547870] systemd[1]: modprobe@configfs.service: Deactivated successfully. worker # [ 6.552932] systemd[1]: Finished Load Kernel Module configfs. worker # [ 6.555332] systemd[1]: Mounted FUSE Control File System. worker # [ 6.560578] systemd[1]: Mounting Kernel Configuration File System... worker # [ 6.567603] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... worker # [ 6.576129] systemd[1]: Mounted Kernel Configuration File System. worker # [ 6.584040] systemd-journald[299]: Collecting audit messages is enabled. worker # [ 6.586347] EXT4-fs (vda): re-mounted af339342-6900-4166-a2fd-1b2b716286e2. worker # [ 6.591208] loop: module loaded worker # [ 6.601384] systemd[1]: Finished Remount Root and Kernel File Systems. worker # [ 6.605436] systemd[1]: Finished Load Kernel Modules. worker # [ 6.608009] systemd[1]: Listening on Disk Image Download Service Socket. worker # [ 6.616608] systemd[1]: Starting Firewall... worker # [ 6.618070] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 6.629632] systemd[1]: Starting Load/Save OS Random Seed... worker # [ 6.635590] systemd[1]: Starting Apply Kernel Variables... worker # [ 6.637571] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 6.670574] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. worker # [ 6.679672] systemd[1]: Starting Create Static Device Nodes in /dev... worker # [ 6.703692] systemd[1]: Finished Load/Save OS Random Seed. worker # [ 6.705912] systemd[1]: Reached target First Boot Complete. worker # [ 6.493245] systemd[1]: Queued start job for default target Multi-User System.[ 6.709313] systemd[1]: Started Journal Service. worker # worker # [ 6.504115] systemd[1]: Unnecessary job was removed for /dev/vdb. worker # [ 6.515578] systemd[1]: systemd-journald.service: Deactivated successfully. worker # [ 6.518824] systemd-modules-load[300]: Inserted module 'loop' worker # [ 6.531721] systemd[1]: Starting Flush Journal to Persistent Storage... worker # [ 6.542176] systemd[1]: Finished Apply Kernel Variables. worker # [ 6.554503] systemd-oomd[302]: No swap; memory pressure usage will be degraded worker # [ 6.564132] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. worker # [ 6.573213] systemd[1]: Finished Create Static Device Nodes in /dev. worker # [ 6.574799] systemd[1]: Reached target Preparation for Local File Systems. worker # [ 6.793655] systemd-journald[299]: Received client request to flush runtime journal. hub # [ 13.199135] dhcpcd[787]: eth0: soliciting an IPv6 router hub # [ 13.201209] dhcpcd[787]: eth0: Router Advertisement from fe80::2 hub # [ 13.202929] dhcpcd[787]: eth0: adding address fec0::5054:ff:fe12:3456/64 hub # [ 13.204634] tailscaled[701]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 hub # [ 13.206435] dhcpcd[787]: eth0: adding route to fec0::/64 hub # [ 13.209257] dhcpcd[787]: eth0: adding default route via fe80::2 hub # [ 13.210857] tailscaled[701]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 hub # [ 13.215105] tailscaled[701]: 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::c5f7:5332:90ab:5b42/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::c5f7:5332:90ab:5b42/64] rebind-reason=[default-if-changed] hub # [ 13.223735] tailscaled[701]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 13.225946] tailscaled[701]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 13.227976] tailscaled[701]: dns: OScfg: {} hub # [ 13.253602] tailscaled[701]: wgengine: set DNS config again after major link change hub # [ 13.256093] tailscaled[701]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::c5f7:5332:90ab:5b42/64] hub # [ 13.259126] tailscaled[701]: magicsock: 0 active derp conns hub # [ 13.261618] tailscaled[701]: router: portUpdate(port=41641, network=udp6) hub # [ 13.263361] tailscaled[701]: router: portUpdate(port=41641, network=udp4) worker # [ 6.772696] systemd[1]: Starting Rule-based Manager for Device Events and Files... worker # [ 6.779759] systemd-udevd[329]: Using default interface naming scheme 'v261'. worker # [ 6.785102] systemd[1]: Started Rule-based Manager for Device Events and Files. worker # [ 6.786763] systemd[1]: Finished Flush Journal to Persistent Storage. worker # [ 6.837849] systemd[1]: Finished Coldplug All udev Devices. worker # [ 6.950116] systemd[1]: Finished Firewall. worker # [ 6.975102] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse worker # [ 7.040531] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. worker # [ 7.067817] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. worker # [ 7.074109] (udev-worker)[369]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. worker # [ 7.083963] (udev-worker)[369]: Network interface NamePolicy= disabled on kernel command line. worker # [ 7.092716] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line. worker # [ 7.140796] systemd[1]: Mounting /run/wrappers... worker # [ 7.142071] systemd[1]: Condition check resulted in Virtio network device being skipped. worker # [ 7.143758] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore worker # [ 7.147369] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 worker # [ 7.150319] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore worker # [ 7.154107] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 7.155808] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os worker # [ 7.168836] systemd[1]: Mounted /run/wrappers. worker # [ 7.170731] systemd[1]: Reached target Local File Systems. worker # [ 7.173089] systemd[1]: Listening on Boot Loader Control Service Socket. worker # [ 7.178436] systemd[1]: Starting register-nix-paths.service... worker # [ 7.182127] systemd[1]: Starting Create SUID/SGID Wrappers... worker # [ 7.185536] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. worker # [ 7.187281] systemd[1]: Starting Save Transient machine-id to Disk... worker # [ 7.193724] systemd[1]: Starting Create System Files and Directories... worker # [ 7.228804] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. worker # [ 7.236161] systemd[1]: Finished Save Transient machine-id to Disk. worker # [ 7.262980] systemd[1]: Finished Create System Files and Directories. worker # [ 7.267094] systemd[1]: Starting Rebuild Journal Catalog... worker # [ 7.273095] systemd[1]: Starting Record System Boot/Shutdown in UTMP... worker # [ 7.323289] systemd[1]: Finished Record System Boot/Shutdown in UTMP. worker # [ 7.368797] systemd[1]: Finished Rebuild Journal Catalog. worker # [ 7.374100] systemd[1]: Starting Update is Completed... worker # [ 7.411409] systemd[1]: Finished Update is Completed. worker # [ 7.710433] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 worker # [ 7.724657] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console worker # [ 7.518179] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. worker # [ 7.519662] systemd[1]: Finished Create SUID/SGID Wrappers. worker # [ 7.746139] mousedev: PS/2 mouse device common for all mice worker # [ 7.781386] ACPI: button: Power Button [PWRF] worker # [ 7.834135] Console: switching to colour dummy device 80x25 worker # [ 7.857580] rtc_cmos 00:04: RTC can wake from S4 worker # [ 7.872428] [drm] Found bochs VGA, ID 0xb0c5. worker # [ 7.872430] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. worker # [ 7.881790] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized worker # [ 7.897003] parport_pc 00:02: reported by Plug and Play ACPI worker # [ 7.898564] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic worker # [ 7.899509] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 worker # [ 7.692130] systemd[1]: Finished register-nix-paths.service. worker # [ 7.695331] systemd[1]: Reached target System Initialization. worker # [ 7.696565] systemd[1]: Started Discard unused filesystem blocks once a week. worker # [ 7.699217] systemd[1]: Started Daily Cleanup of Temporary Directories. worker # [ 7.700896] systemd[1]: Reached target Timer Units. worker # [ 7.703726] systemd[1]: Listening on D-Bus System Message Bus Socket. worker # [ 7.706192] systemd[1]: Listening on Nix Daemon Socket. worker # [ 7.707329] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. worker # [ 7.711580] systemd[1]: Listening on tribuchet build agent 1 socket. worker # [ 7.927868] rtc_cmos 00:04: registered as rtc0 worker # [ 7.928580] rtc_cmos 00:04: setting system clock to 2026-08-31T10:18:21 UTC (1788171501) worker # [ 7.718343] systemd[1]: Reached target Socket Units. worker # [ 7.719730] systemd[1]: Reached target Basic System. worker # [ 7.725517] systemd[1]: Started backdoor.service. worker # [ 7.726755] systemd[1]: Starting Import lastlog data into lastlog2 database... worker # [ 7.734210] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 7.735602] systemd[1]: Starting Post-Boot Actions... worker # [ 7.743461] systemd[1]: Started Reset console on configuration changes. worker # [ 7.746381] systemd[1]: Starting resolvconf update... worker # [ 7.752504] systemd[1]: Starting D-Bus System Message Bus... hub # [ 14.325078] tailscaled[701]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 7.802323] systemd[1]: Finished Post-Boot Actions. worker # [ 8.021065] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 worker # connecting to host... worker # [ 7.838487] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 7.844092] nsncd[528]: Aug 31 10:18:21.623 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 7.851884] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 7.853300] systemd[1]: Reached target User and Group Name Lookups. worker # [ 7.859266] systemd[1]: Starting User Login Management... worker # [ 7.860437] systemd[1]: Finished Import lastlog data into lastlog2 database. worker # [ 8.086945] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] worker # [ 8.091630] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs worker # [ 7.884816] dbus-broker-launch[533]: Looking up NSS user entry for 'systemd-timesync'... worker # [ 7.890528] dbus-broker-launch[533]: NSS returned no entry for 'systemd-timesync' worker # [ 7.893169] dbus-broker-launch[533]: Invalid user-name in /nix/store/n5ll7xdl183qaiv6c0nj497ap99mn34g-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" worker # [ 7.904665] systemd[1]: Started D-Bus System Message Bus. worker # [ 7.937445] dbus-broker-launch[533]: Ready worker # [ 7.980146] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 7.981591] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 7.982826] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 7.987298] systemd[1]: Stopping User and Group Name Lookups... worker # [ 7.990800] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 7.995398] systemd[1]: nscd.service: Deactivated successfully. worker # [ 8.364150] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt worker # [ 8.364255] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD worker # [ 8.400409] Console: switching to colour frame buffer device 160x50 worker # [ 8.523907] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device worker # [ 7.999376] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 8.316194] dhcpcd[639]: dhcpcd-10.3.2 starting worker # [ 8.318837] systemd[1]: nscd.service: Consumed 15ms CPU time over 273ms wall clock time, 6.9M memory peak, 5.5M read from disk. worker # [ 8.537611] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 worker # [ 8.539162] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 worker # [ 8.551176] 8021q: 802.1Q VLAN Support v1.8 worker # [ 8.338321] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 8.555218] 8021q: adding VLAN 0 to HW filter on device eth1 worker # [ 8.345120] dhcpcd[695]: dev: loaded udev worker # [ 8.351300] systemd[1]: Finished resolvconf update. worker # [ 8.361530] nsncd[600]: Aug 31 10:18:21.818 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 8.365538] network-addresses-eth1-start[625]: adding address 192.168.1.2/24... done hub # [ 14.901402] tailscaled[701]: monitor: RTM_NEWROUTE: src=, dst=fec0::c5f7:5332:90ab:5b42/128, gw=, outif=2, table=255 worker # [ 8.378247] network-addresses-eth1-start[625]: adding address 2001:db8:1::2/64... done worker # [ 8.384642] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 8.389528] systemd[1]: Reached target Preparation for Network. worker # [ 8.401309] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 8.410546] systemd[1]: Reached target User and Group Name Lookups. worker # [ 8.414658] systemd[1]: Starting DHCP Client... worker # [ 8.423495] systemd[1]: Starting Address configuration of eth1... worker # [ 8.428665] systemd[1]: Starting Extra networking commands.... worker # [ 8.439478] systemd[1]: Starting Tailscale node agent... worker # [ 8.443213] systemd[1]: Finished Address configuration of eth1. worker # [ 8.446334] systemd[1]: Finished Extra networking commands.. worker # [ 8.451917] systemd[1]: Reached target Network. worker # [ 8.453551] systemd-logind[553]: New seat seat0. worker # [ 8.463360] systemd[1]: Starting Permit User Sessions... worker # [ 8.464687] systemd[1]: Started User Login Management. worker # [ 8.475257] systemd[1]: Starting linger-users.service... worker # [ 8.485147] systemd[1]: Finished Permit User Sessions. worker # [ 8.494881] tailscaled[627]: TPM: error opening: stat /dev/tpmrm0: no such file or directory worker # [ 8.506154] tailscaled[627]: Program starting: v1.102.2, Go 1.26.5: []string{"/nix/store/ilmsaffab3j7a5y17yrfgng1dm111wk1-tailscale-1.102.2/bin/tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port=41641", "--tun", "tailscale0"} worker # [ 8.510625] tailscaled[627]: LogID: eb684fc375835ed90d0590abc8483cac72eafa00a70a1f04b0331e415c2ce5ce worker # [ 8.519057] tailscaled[627]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 8.736721] cfg80211: Loading compiled-in X.509 certificates for regulatory database worker # [ 8.527170] tailscaled[627]: logpolicy.ConfigFromFile /var/lib/tailscale/tailscaled.log.conf: open /var/lib/tailscale/tailscaled.log.conf: no such file or directory worker # [ 8.746867] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' worker # [ 8.533621] tailscaled[627]: logpolicy.Config.Validate for /var/lib/tailscale/tailscaled.log.conf: config is nil worker # [ 8.535753] systemd[1]: Started Getty on tty1. worker # [ 8.751670] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' worker # [ 8.755137] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 worker # [ 8.756521] cfg80211: failed to load regulatory.db worker # [ 8.544223] systemd[1]: Reached target Login Prompts. worker # [ 8.546478] systemd[1]: linger-users.service: Deactivated successfully. worker # [ 8.550563] systemd[1]: Finished linger-users.service. worker # [ 8.561107] tailscaled[627]: logtail: dial "log.tailscale.com:443" failed: dial tcp: lookup log.tailscale.com on [::1]:53: read udp [::1]:52657->[::1]:53: read: connection refused (in 44ms), trying bootstrap... worker # [ 8.575646] tailscaled[627]: trying bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" ... worker # [ 8.580084] tailscaled[627]: bootstrapDNS("derp11.tailscale.com", "18.230.97.74") for "log.tailscale.com" error: Get "https://derp11.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 18.230.97.74:443: connect: network is unreachable worker # [ 8.587238] tailscaled[627]: trying bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" ... worker # [ 8.589779] tailscaled[627]: bootstrapDNS("derp12.tailscale.com", "2001:19f0:5c01:289:5400:3ff:fe8d:cb5e") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:289:5400:3ff:fe8d:cb5e]:443: connect: network is unreachable worker # [ 8.594695] tailscaled[627]: trying bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" ... worker # [ 8.596802] tailscaled[627]: bootstrapDNS("derp4c.tailscale.com", "134.122.77.138") for "log.tailscale.com" error: Get "https://derp4c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 134.122.77.138:443: connect: network is unreachable worker # [ 8.603282] tailscaled[627]: trying bootstrapDNS("derp1c.tailscale.com", "2604:a880:800:10::7a0:e001") for "log.tailscale.com" ... worker # [ 8.605914] dbus-broker-launch[533]: Activation request for 'org.freedesktop.resolve1' failed: The systemd unit 'dbus-org.freedesktop.resolve1.service' could not be found. worker # [ 8.611531] tailscaled[627]: 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.616810] tailscaled[627]: trying bootstrapDNS("derp2f.tailscale.com", "208.111.34.178") for "log.tailscale.com" ... worker # [ 8.621306] tailscaled[627]: 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.625447] tailscaled[627]: trying bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" ... worker # [ 8.630095] tailscaled[627]: bootstrapDNS("derp1d.tailscale.com", "2604:a880:800:10::7fe:f001") for "log.tailscale.com" error: Get "https://derp1d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2604:a880:800:10::7fe:f001]:443: connect: network is unreachable worker # [ 8.639068] tailscaled[627]: trying bootstrapDNS("derp2e.tailscale.com", "192.73.252.134") for "log.tailscale.com" ... worker # [ 8.641228] tailscaled[627]: 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.645187] tailscaled[627]: trying bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" ... worker # [ 8.647646] tailscaled[627]: bootstrapDNS("derp12b.tailscale.com", "2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f") for "log.tailscale.com" error: Get "https://derp12b.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2001:19f0:5c01:48a:5400:3ff:fe8d:cb5f]:443: connect: network is unreachable worker # [ 8.652324] tailscaled[627]: trying bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" ... worker # [ 8.664108] tailscaled[627]: bootstrapDNS("derp1c.tailscale.com", "104.248.8.210") for "log.tailscale.com" error: Get "https://derp1c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 104.248.8.210:443: connect: network is unreachable worker # [ 8.667720] tailscaled[627]: trying bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" ... worker # [ 8.670295] tailscaled[627]: bootstrapDNS("derp8c.tailscale.com", "2a03:b0c0:1:d0::e1f:4001") for "log.tailscale.com" error: Get "https://derp8c.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2a03:b0c0:1:d0::e1f:4001]:443: connect: network is unreachable worker # [ 8.674106] tailscaled[627]: trying bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" ... worker # [ 8.678149] tailscaled[627]: bootstrapDNS("derp12.tailscale.com", "216.128.144.130") for "log.tailscale.com" error: Get "https://derp12.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp 216.128.144.130:443: connect: network is unreachable worker # [ 8.681856] tailscaled[627]: trying bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" ... worker # [ 8.683958] tailscaled[627]: bootstrapDNS("derp2d.tailscale.com", "2607:f740:0:3f::287") for "log.tailscale.com" error: Get "https://derp2d.tailscale.com/bootstrap-dns?q=log.tailscale.com": dial tcp [2607:f740:0:3f::287]:443: connect: network is unreachable worker # [ 8.688061] tailscaled[627]: logtail: upload: log upload of 466 bytes compressed failed: Post "https://log.tailscale.com/c/tailnode.log.tailscale.io/60d7c106d66dfe6f382cb96f7ef1178d7be010dbb0b6eb0fe4b19ae68bbbb962": failed to resolve "log.tailscale.com": no DNS fallback candidates remain for "log.tailscale.com" worker # [ 8.912166] 8021q: adding VLAN 0 to HW filter on device eth0 worker # [ 8.701786] dhcpcd[695]: eth0: waiting for carrier worker # [ 8.705080] dhcpcd[695]: libudev: received NULL device worker # [ 8.706131] dhcpcd[695]: libudev: received NULL device worker # [ 8.707327] dhcpcd[695]: eth0: carrier acquired worker # [ 8.711333] tailscaled[627]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.712974] tailscaled[627]: dns: using "openresolv" mode worker # [ 8.714061] tailscaled[627]: dns: using dns.openresolvManager worker # [ 8.722708] dhcpcd[695]: DUID 00:01:00:01:32:28:11:6e:52:54:00:12:34:56 worker # [ 8.724896] dhcpcd[695]: eth0: IAID 00:12:34:56 hub # [ 15.252885] dhcpcd[787]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 8.726060] dhcpcd[695]: eth0: adding address fe80::5054:ff:fe12:3456 hub # [ 15.254239] dhcpcd[787]: eth0: adding route to 10.0.2.0/24 hub # [ 15.255446] dhcpcd[787]: eth0: adding default route via 10.0.2.2 hub # [ 15.258230] tailscaled[701]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 hub # [ 15.260605] tailscaled[701]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 hub # [ 15.262964] tailscaled[701]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 hub # [ 15.265291] tailscaled[701]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 8.748735] systemd[1]: Starting Virtual Console Setup... worker # [ 8.790661] systemd-logind[553]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) worker # [ 8.796629] systemd-logind[553]: Watching system buttons on /dev/input/event2 (Power Button) hub # [ 15.331239] systemd[1]: Started DHCP Client. hub # [ 15.333617] systemd[1]: Reached target Network is Online. hub # [ 15.337812] systemd[1]: Started headscale coordination server for Tailscale. hub # [ 15.341055] systemd[1]: Reached target Multi-User System. hub # [ 15.342538] systemd[1]: Startup finished in 1.075s (kernel) + 4.041s (initrd) + 10.226s (userspace) = 15.342s. worker # [ 8.820584] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 8.823533] systemd[1]: Stopped Virtual Console Setup. worker # [ 8.825899] systemd[1]: Starting Virtual Console Setup... worker # [ 8.881249] systemd-vconsole-setup[743]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 8.886741] systemd[1]: Finished Virtual Console Setup. worker # [ 8.891244] tailscaled[627]: router: enumerating tailscale0 addresses for cleanup failed: failed to look up link "tailscale0": Link not found worker # [ 8.895452] systemd[1]: Started Tailscale node agent. worker # [ 8.897573] tailscaled[627]: wgengine.NewUserspaceEngine(tun "tailscale0") ... worker # [ 9.118982] tun: Universal TUN/TAP device driver, 1.6 worker # [ 9.131587] ppdev: user-space parallel port driver hub: (finished: waiting for unit headscale, in 9.78 seconds) worker # [ 9.139238] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) hub: waiting for TCP port 443 on localhost worker # [ 8.944854] tailscaled[627]: dns: [rc=resolvconf resolvconf=openresolv ret=openresolv] worker # [ 8.946758] tailscaled[627]: dns: using "openresolv" mode worker # [ 8.965542] tailscaled[627]: dns: using dns.openresolvManager worker # [ 8.968882] tailscaled[627]: link state: interfaces.State{defaultRoute= ifs={eth1:[192.168.1.2/24 2001:db8:1::2/64 llu6]} v4=true v6=true} worker # [ 8.981166] systemd-logind[553]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) worker # [ 9.202199] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0) worker # [ 8.992098] tailscaled[627]: router: portUpdate(port=41641, network=udp6) worker # [ 8.994201] tailscaled[627]: router: using firewall mode pref worker # [ 9.011320] tailscaled[627]: router: default choosing iptables worker # [ 9.031314] tailscaled[627]: magicsock: disco key = d:7e30184f6e2163c2 worker # [ 9.032982] tailscaled[627]: Creating WireGuard device... worker # [ 9.034935] tailscaled[627]: Bringing WireGuard device up... worker # [ 9.050438] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. worker # [ 9.054422] systemd[1]: Stopped Virtual Console Setup. worker # [ 9.061310] systemd[1]: Stopping Virtual Console Setup... worker # [ 9.062774] systemd[1]: Starting Virtual Console Setup... worker # [ 9.080605] tailscaled[627]: Bringing router up... worker # [ 9.088495] tailscaled[627]: external route: up worker # [ 9.125148] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. worker # [ 9.129845] tailscaled[627]: router: netfilter running in iptables mode v6 = true, v6filter = true, v6nat = true worker # [ 9.134111] tailscaled[627]: router: portUpdate(port=41641, network=udp4) worker # [ 9.143938] tailscaled[627]: Clearing router settings... worker # [ 9.149445] tailscaled[627]: Starting network monitor... worker # [ 9.157433] (udev-worker)[385]: Network interface NamePolicy= disabled on kernel command line. worker # [ 9.168460] tailscaled[627]: Engine created. worker # [ 9.177493] systemd-vconsole-setup[766]: Configuration of first virtual console was skipped, ignoring remaining ones. worker # [ 9.185245] systemd[1]: Finished Virtual Console Setup. worker # [ 9.220368] tailscaled[627]: pm: migrating "_daemon" profile to new format worker # [ 9.223471] tailscaled[627]: envknob: PORT="41641" worker # [ 9.226748] tailscaled[627]: logpolicy: using $STATE_DIRECTORY, "/var/lib/tailscale" worker # [ 9.229794] tailscaled[627]: linkChange: in state NoState; PAC or proxyConfig changed; updating routes worker # [ 9.232803] tailscaled[627]: got LocalBackend in 335ms worker # [ 9.235611] tailscaled[627]: Start worker # [ 9.238052] tailscaled[627]: ipnext: "conn25": skipping extension worker # [ 9.242311] tailscaled[627]: ipnext: active extensions: captiveportal, acme, portlist, posture, clientupdate, relayserver, routecheck, serviceclientprefs, taildrop worker # [ 9.249739] tailscaled[627]: profile data directory: profile not found worker # [ 9.253721] tailscaled[627]: Backend: logs: be:eb684fc375835ed90d0590abc8483cac72eafa00a70a1f04b0331e415c2ce5ce fe: worker # [ 9.256182] tailscaled[627]: Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false) worker # [ 9.262358] tailscaled[627]: blockEngineUpdates(true) worker # [ 9.263942] tailscaled[627]: wgengine: Reconfig: configuring router worker # [ 9.270898] tailscaled[627]: wgengine: Reconfig: user dialer worker # [ 9.272396] tailscaled[627]: wgengine: Reconfig: configuring DNS worker # [ 9.274083] tailscaled[627]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 9.276192] tailscaled[627]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 9.280354] tailscaled[627]: health(warnable=wantrunning-false): error: Tailscale is stopped. worker # [ 9.283566] tailscaled[627]: dns: OScfg: {} worker # [ 9.405965] dhcpcd[695]: eth0: soliciting a DHCP lease worker # [ 9.689748] NET: Registered PF_PACKET protocol family worker # [ 9.481141] dhcpcd[695]: eth0: offered 10.0.2.15 from 10.0.2.2 worker # [ 9.486407] dhcpcd[695]: eth0: probing address 10.0.2.15/24 worker # [ 9.730901] kvm_amd: TSC scaling supported worker # [ 9.731827] kvm_amd: Nested Virtualization enabled worker # [ 9.733375] kvm_amd: Nested Paging enabled worker # [ 9.734358] kvm_amd: LBR virtualization supported worker # [ 9.735741] kvm_amd: Virtual VMLOAD VMSAVE supported worker # [ 9.736845] kvm_amd: Virtual GIF supported worker # [ 9.783733] EDAC MC: Ver: 3.0.0 hub # [ 16.219572] tailscaled[701]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::c5f7:5332:90ab:5b42/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::c5f7:5332:90ab:5b42/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::c5f7:5332:90ab:5b42/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::c5f7:5332:90ab:5b42/64] rebind-reason=[ips-changed] hub # [ 16.577226] tailscaled[701]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} hub # [ 16.579480] tailscaled[701]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} hub # [ 16.581293] tailscaled[701]: dns: OScfg: {} worker # [ 10.672453] dhcpcd[695]: eth0: soliciting an IPv6 router worker # [ 10.677137] dhcpcd[695]: eth0: Router Advertisement from fe80::2 worker # [ 10.679714] dhcpcd[695]: eth0: adding address fec0::5054:ff:fe12:3456/64 worker # [ 10.685270] dhcpcd[695]: eth0: adding route to fec0::/64 worker # [ 10.691705] tailscaled[627]: monitor: RTM_NEWROUTE: src=, dst=fec0::/64, gw=, outif=2, table=254 worker # [ 10.693734] tailscaled[627]: monitor: RTM_NEWROUTE: src=, dst=, gw=fe80::2, outif=2, table=254 worker # [ 10.700384] dhcpcd[695]: eth0: adding default route via fe80::2 hub # Connection to localhost (::1) 443 port [tcp/https] succeeded! hub: (finished: waiting for TCP port 443 on localhost, in 1.99 seconds) hub: waiting for unit tailscaled hub # [ 17.645511] tailscaled[701]: wgengine: set DNS config again after major link change hub # [ 17.650732] tailscaled[701]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::c5f7:5332:90ab:5b42/64] hub # [ 17.656740] tailscaled[701]: magicsock: 0 active derp conns hub # [ 17.672156] tailscaled[701]: router: portUpdate(port=41641, network=udp6) hub # [ 17.677742] tailscaled[701]: router: portUpdate(port=41641, network=udp4) hub # [ 17.679866] tailscaled[701]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 17.698765] tailscaled[701]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 11.172288] tailscaled[627]: 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::7b9c:e0b5:2ee0:244c/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::7b9c:e0b5:2ee0:244c/64] rebind-reason=[default-if-changed] worker # [ 11.186845] tailscaled[627]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 11.189339] tailscaled[627]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 11.191485] tailscaled[627]: dns: OScfg: {} worker # [ 11.237297] tailscaled[627]: wgengine: set DNS config again after major link change worker # [ 11.244617] tailscaled[627]: Rebind; defIf="eth0", ips=[fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7b9c:e0b5:2ee0:244c/64] worker # [ 11.252200] tailscaled[627]: magicsock: 0 active derp conns worker # [ 11.257723] tailscaled[627]: router: portUpdate(port=41641, network=udp6) worker # [ 11.271917] tailscaled[627]: router: portUpdate(port=41641, network=udp4) worker # [ 12.211203] tailscaled[627]: monitor: RTM_NEWROUTE: src=, dst=fec0::5054:ff:fe12:3456/128, gw=, outif=2, table=255 worker # [ 12.527928] tailscaled[627]: monitor: RTM_NEWROUTE: src=, dst=fec0::7b9c:e0b5:2ee0:244c/128, gw=, outif=2, table=255 hub: (finished: waiting for unit tailscaled, in 1.84 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.06 seconds) hub: must succeed: headscale users create test worker # [ 14.259571] dhcpcd[695]: eth0: leased 10.0.2.15 for 86400 seconds worker # [ 14.269144] dhcpcd[695]: eth0: adding route to 10.0.2.0/24 worker # [ 14.271910] dhcpcd[695]: eth0: adding default route via 10.0.2.2 worker # [ 14.275878] tailscaled[627]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.15/32, gw=, outif=2, table=255 worker # [ 14.279573] tailscaled[627]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.255/32, gw=, outif=2, table=255 worker # [ 14.282218] tailscaled[627]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=10.0.2.0/24, gw=, outif=2, table=254 worker # [ 14.286742] tailscaled[627]: monitor: RTM_NEWROUTE: src=10.0.2.15/0, dst=, gw=10.0.2.2, outif=2, table=254 worker # [ 14.293110] tailscaled[627]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute=eth0 ifs={eth0:[llu6 fec0::5054:ff:fe12:3456/64 fec0::7b9c:e0b5:2ee0:244c/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::7b9c:e0b5:2ee0:244c/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::7b9c:e0b5:2ee0:244c/64]->[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7b9c:e0b5:2ee0:244c/64] rebind-reason=[ips-changed] worker # [ 14.306503] tailscaled[627]: dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0} worker # [ 14.310457] tailscaled[627]: dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]} worker # [ 14.313493] tailscaled[627]: dns: OScfg: {} worker # [ 14.388682] systemd[1]: Started DHCP Client. worker # [ 14.392365] systemd[1]: Reached target Multi-User System. worker # [ 14.393962] systemd[1]: Startup finished in 967ms (kernel) + 4.360s (initrd) + 9.064s (userspace) = 14.392s. worker # [ 15.367261] tailscaled[627]: wgengine: set DNS config again after major link change worker # [ 15.373153] tailscaled[627]: Rebind; defIf="eth0", ips=[10.0.2.15/24 fe80::5054:ff:fe12:3456/64 fec0::5054:ff:fe12:3456/64 fec0::7b9c:e0b5:2ee0:244c/64] worker # [ 15.376759] tailscaled[627]: magicsock: 0 active derp conns worker # [ 15.380136] tailscaled[627]: monitor: gateway and self IP changed: gw=10.0.2.2 self=10.0.2.15 worker # [ 15.382927] tailscaled[627]: router: portUpdate(port=41641, network=udp6) worker # [ 15.385513] tailscaled[627]: router: portUpdate(port=41641, network=udp4) worker # [ 15.390308] tailscaled[627]: [RATELIMIT] format("router: portUpdate(port=%v, network=%s)") hub # [ 22.057777] headscale-start[978]: 2026-08-31T10:18:29Z INF no private key file at path, creating... path=/var/lib/headscale/noise_private.key hub # [ 22.071882] headscale-start[978]: 2026-08-31T10:18:29Z INF Opening database database=sqlite3 path=/var/lib/headscale/db.sqlite hub # [ 22.834193] headscale-start[978]: 2026-08-31T10:18:29Z INF no private key file at path, creating... path=/var/lib/headscale/derp_server_private.key hub # [ 22.870665] headscale-start[978]: 2026-08-31T10:18:29Z INF starting headscale commit=v0.29.3 version=0.29.3 hub # [ 22.878394] headscale-start[978]: 2026-08-31T10:18:29Z INF Clients with a lower minimum version will be rejected minimum_version=v1.80 hub # [ 22.893419] headscale-start[978]: 2026-08-31T10:18:29Z 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:[0x3d107c4aa120]} hub # [ 22.909375] headscale-start[978]: 2026-08-31T10:18:29Z 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 # [ 22.948704] headscale-start[978]: 2026-08-31T10:18:29Z INF stun server started at [::]:3478 hub # [ 22.960194] headscale-start[978]: 2026-08-31T10:18:29Z INF HA subnet router health probing enabled interval=10000 timeout=5000 hub # [ 22.976155] headscale-start[978]: 2026-08-31T10:18:29Z WRN listening without TLS but ServerURL does not start with http:// hub # [ 23.031417] headscale-start[978]: 2026-08-31T10:18:29Z INF listening and serving HTTP on: 127.0.0.1:8080 hub # [ 23.034407] headscale-start[978]: 2026-08-31T10:18:29Z INF metrics server disabled (metrics_listen_addr is empty) hub # [ 23.399080] headscale-start[978]: 2026-08-31T10:18:30Z INF user created user.name=test hub: (finished: must succeed: headscale users create test, in 4.15 seconds) hub: must succeed: headscale preauthkeys -u 1 create --reusable hub: (finished: must succeed: headscale preauthkeys -u 1 create --reusable, in 0.43 seconds) hub: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-91l2UsdlhtJZ-42336ZcdWiCtb2A2mEFCi811P39yQbkBSbtxpyhfuPeegch0NnYe2hzRjh1uq_M3 --hostname hub hub # [ 24.322302] tailscaled[701]: localapi: [POST] /localapi/v0/check-prefs hub # [ 24.326094] tailscaled[701]: localapi: [POST] /localapi/v0/start hub # [ 24.328768] tailscaled[701]: control: client.Shutdown ... hub # [ 24.330689] tailscaled[701]: control: mapRoutine: exiting hub # [ 24.333342] tailscaled[701]: control: authRoutine: exiting hub # [ 24.335216] tailscaled[701]: control: updateRoutine: exiting hub # [ 24.338134] tailscaled[701]: control: Client.Shutdown done. hub # [ 24.340391] tailscaled[701]: Start hub # [ 24.341947] tailscaled[701]: 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 # [ 24.346470] tailscaled[701]: generating new machine key hub # [ 24.364611] tailscaled[701]: machine key written to store hub # [ 24.367106] tailscaled[701]: profile data directory: profile not found hub # [ 24.368841] tailscaled[701]: Backend: logs: be:7618311e817bc76edacf84f9bd84b514523f98d894042b310c5b8f9fb5fd3bac fe: hub # [ 24.374968] tailscaled[701]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) hub # [ 24.378883] tailscaled[701]: blockEngineUpdates(true) hub # [ 24.380672] tailscaled[701]: Reconfig(down): no changes made to Engine config hub # [ 24.385471] tailscaled[701]: health(warnable=warming-up): error: Tailscale is starting. Please wait. hub # [ 24.388479] tailscaled[701]: health(warnable=wantrunning-false): ok hub # [ 24.395446] tailscaled[701]: localapi: [POST] /localapi/v0/login-interactive hub # [ 24.397409] tailscaled[701]: StartLoginInteractiveAs("root"): url=false hub # [ 24.399109] tailscaled[701]: control: client.Login(2) hub # [ 24.406173] tailscaled[701]: control: LoginInteractive -> regen=true hub # [ 24.408808] tailscaled[701]: control: doLogin(regen=true, hasUrl=false) hub # [ 24.505414] tailscaled[701]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 24.520499] headscale-start[978]: 2026-08-31T10:18:31Z INF http request bytes=176 elapsed=2.532445 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:49924 status=200 hub # [ 24.537502] tailscaled[701]: control: control server key from https://hub: ts2021=[33v3Z], legacy= hub # [ 24.540700] tailscaled[701]: control: Generating a new nodekey. hub # [ 24.546918] tailscaled[701]: control: RegisterReq: onode= node=[vTAy4] fup=false nks=false hub # [ 25.383504] headscale-start[978]: 2026-08-31T10:18:32Z INF http request bytes=249 elapsed=812.396826 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:49928 status=200 hub # [ 25.387514] tailscaled[701]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false hub # [ 25.393990] tailscaled[701]: blockEngineUpdates(false) hub # [ 25.886181] headscale-start[978]: 2026-08-31T10:18:32Z INF http request bytes=0 elapsed=493.290069 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49928 status=200 hub # [ 26.385122] headscale-start[978]: 2026-08-31T10:18:33Z INF node connected machine.key=[053tg] node.expired=false node.id=1 node.is_tagged=false node.key=[vTAy4] node.name=hub node.online=true user.name=test hub # [ 26.389553] headscale-start[978]: 2026-08-31T10:18:33Z INF github.com/juanfont/headscale/hscontrol/poll.go:250 > node has connected chan=0x3d107c2247e0 component=poll machine.key=[053tg] node.expired=false node.id=1 node.is_tagged=false node.key=[vTAy4] node.name=hub node.online=false omit_peers=false stream=true user.name=test hub # [ 26.418143] tailscaled[701]: magicsock: new contact: control-netmap usec=15896368 cached=false hub # [ 26.421338] tailscaled[701]: active login: test hub # [ 26.431243] tailscaled[701]: netmap: suggested exit node: no preferred DERP, try again later hub # [ 26.433804] tailscaled[701]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) hub # [ 26.438814] tailscaled[701]: magicsock: SetPrivateKey called (init) hub # [ 26.440858] tailscaled[701]: wgengine: Reconfig: configuring router hub # [ 26.679535] tailscaled[701]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [14ms] (forced=false) hub # [ 26.681546] tailscaled[701]: magicsock: home is now derp-999 () hub # [ 26.683741] tailscaled[701]: 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::c5f7:5332:90ab:5b42]:41641 (local) hub # [ 26.687250] tailscaled[701]: magicsock: adding connection to derp-999 for home-keep-alive hub # [ 26.690052] tailscaled[701]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s hub # [ 26.692729] tailscaled[701]: derphttp.Client.Connect: connecting to derp-999 () hub # [ 26.700097] tailscaled[701]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" hub # [ 26.712428] tailscaled[701]: magicsock: derp-999 connected; connGen=1 hub # [ 26.772825] tailscaled[701]: router: enabling connmark-based rp_filter workaround hub # [ 26.831497] tailscaled[701]: wgengine: Reconfig: user dialer hub # [ 26.833081] tailscaled[701]: tsdial: bart table size: 2 hub # [ 26.834374] tailscaled[701]: wgengine: Reconfig: configuring DNS hub # [ 26.835769] tailscaled[701]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} hub # [ 26.867113] tailscaled[701]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} hub # [ 26.869107] tailscaled[701]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 26.927384] systemd[1]: Stopped target Host and Network Name Lookups. hub # [ 26.929266] systemd[1]: Stopping Host and Network Name Lookups... hub # [ 26.932666] systemd[1]: Stopped target User and Group Name Lookups. hub # [ 26.934307] systemd[1]: Stopping User and Group Name Lookups... hub # [ 26.936361] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... hub # [ 26.938660] systemd[1]: nscd.service: Deactivated successfully. hub # [ 26.940892] systemd[1]: Stopped Name Service Cache Daemon (nsncd). hub # [ 26.952940] systemd[1]: Starting Name Service Cache Daemon (nsncd)... hub # [ 26.975965] tailscaled[701]: peerapi: serving on http://100.64.0.1:58436 hub # [ 26.977543] tailscaled[701]: peerapi: serving on http://[fd7a:115c:a1e0::1]:59780 hub # [ 26.984097] tailscaled[701]: updating netmap in disk cache hub # [ 26.988324] tailscaled[701]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) hub # [ 26.992697] tailscaled[701]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub # [ 26.997863] nsncd[1136]: Aug 31 10:18:33.953 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" hub # [ 27.001667] systemd[1]: Started Name Service Cache Daemon (nsncd). hub # [ 27.005301] systemd[1]: Reached target Host and Network Name Lookups. hub # [ 27.006695] systemd[1]: Reached target User and Group Name Lookups. hub # [ 27.008962] tailscaled[701]: health(warnable=warming-up): ok hub: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-91l2UsdlhtJZ-42336ZcdWiCtb2A2mEFCi811P39yQbkBSbtxpyhfuPeegch0NnYe2hzRjh1uq_M3 --hostname hub, in 3.11 seconds) worker: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-91l2UsdlhtJZ-42336ZcdWiCtb2A2mEFCi811P39yQbkBSbtxpyhfuPeegch0NnYe2hzRjh1uq_M3 --hostname tt-worker worker # [ 20.509571] tailscaled[627]: localapi: [POST] /localapi/v0/check-prefs worker # [ 20.511616] tailscaled[627]: localapi: [POST] /localapi/v0/start worker # [ 20.513127] tailscaled[627]: control: client.Shutdown ... worker # [ 20.514565] tailscaled[627]: control: mapRoutine: exiting worker # [ 20.516049] tailscaled[627]: control: authRoutine: exiting worker # [ 20.517341] tailscaled[627]: control: updateRoutine: exiting worker # [ 20.519715] tailscaled[627]: control: Client.Shutdown done. worker # [ 20.521064] tailscaled[627]: Start worker # [ 20.522432] tailscaled[627]: 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 # [ 20.525586] tailscaled[627]: generating new machine key worker # [ 20.529081] tailscaled[627]: machine key written to store worker # [ 20.530098] tailscaled[627]: profile data directory: profile not found worker # [ 20.531259] tailscaled[627]: Backend: logs: be:eb684fc375835ed90d0590abc8483cac72eafa00a70a1f04b0331e415c2ce5ce fe: worker # [ 20.534189] tailscaled[627]: Switching ipn state NoState -> NeedsLogin (WantRunning=true, nm=false) worker # [ 20.536304] tailscaled[627]: blockEngineUpdates(true) worker # [ 20.537411] tailscaled[627]: Reconfig(down): no changes made to Engine config worker # [ 20.539480] tailscaled[627]: localapi: [POST] /localapi/v0/login-interactive worker # [ 20.541063] tailscaled[627]: StartLoginInteractiveAs("root"): url=false worker # [ 20.542260] tailscaled[627]: control: client.Login(2) worker # [ 20.544876] tailscaled[627]: health(warnable=warming-up): error: Tailscale is starting. Please wait. worker # [ 20.546787] tailscaled[627]: health(warnable=wantrunning-false): ok worker # [ 20.548488] tailscaled[627]: control: LoginInteractive -> regen=true worker # [ 20.549913] tailscaled[627]: control: doLogin(regen=true, hasUrl=false) worker # [ 20.571950] tailscaled[627]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 20.574848] tailscaled[627]: control: control server key from https://hub: ts2021=[33v3Z], legacy= hub # [ 27.101520] headscale-start[978]: 2026-08-31T10:18:34Z INF http request bytes=176 elapsed=0.131302 method=GET path=/key proto=HTTP/1.1 remote=127.0.0.1:49942 status=200 worker # [ 20.577173] tailscaled[627]: control: Generating a new nodekey. worker # [ 20.579527] tailscaled[627]: control: RegisterReq: onode= node=[65g7Y] fup=false nks=false hub # [ 27.387981] headscale-start[978]: 2026-08-31T10:18:34Z INF http request bytes=0 elapsed=404.349435 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49928 status=200 hub # [ 27.887830] headscale-start[978]: 2026-08-31T10:18:34Z INF http request bytes=0 elapsed=494.197727 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49928 status=200 hub # [ 27.892804] headscale-start[978]: 2026-08-31T10:18:34Z INF http request bytes=249 elapsed=779.031971 method=POST path=/machine/register proto=HTTP/2.0 remote=127.0.0.1:49956 status=200 worker # [ 21.370108] tailscaled[627]: control: RegisterReq: got response; nodeKeyExpired=false, machineAuthorized=true; authURL=false worker # [ 21.373265] tailscaled[627]: blockEngineUpdates(false) hub # [ 28.389044] headscale-start[978]: 2026-08-31T10:18:35Z INF http request bytes=0 elapsed=484.57248 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49956 status=200 hub # [ 28.474666] tailscaled[701]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 28.485586] tailscaled[701]: wgengine: Reconfig: configuring router hub # [ 28.487981] tailscaled[701]: wgengine: Reconfig: user dialer hub # [ 28.489367] tailscaled[701]: tsdial: bart table size: 4 hub # [ 28.490602] tailscaled[701]: wgengine: Reconfig: configuring DNS hub # [ 28.491957] tailscaled[701]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} hub # [ 28.531709] tailscaled[701]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} hub # [ 28.534220] tailscaled[701]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } hub # [ 28.889228] headscale-start[978]: 2026-08-31T10:18:35Z INF node connected machine.key=[qfmvX] node.expired=false node.id=2 node.is_tagged=false node.key=[65g7Y] node.name=tt-worker node.online=true user.name=test hub # [ 28.893477] headscale-start[978]: 2026-08-31T10:18:35Z INF github.com/juanfont/headscale/hscontrol/poll.go:250 > node has connected chan=0x3d107c1efb20 component=poll machine.key=[qfmvX] node.expired=false node.id=2 node.is_tagged=false node.key=[65g7Y] node.name=tt-worker node.online=false omit_peers=false stream=true user.name=test worker # [ 22.383892] tailscaled[627]: magicsock: new contact: control-netmap usec=13414507 cached=false worker # [ 22.385930] tailscaled[627]: active login: test worker # [ 22.391887] tailscaled[627]: netmap: suggested exit node: no preferred DERP, try again later worker # [ 22.394262] tailscaled[627]: Switching ipn state NeedsLogin -> Starting (WantRunning=true, nm=true) worker # [ 22.398285] tailscaled[627]: magicsock: SetPrivateKey called (init) worker # [ 22.400440] tailscaled[627]: wgengine: Reconfig: configuring router worker # [ 22.495484] tailscaled[627]: router: enabling connmark-based rp_filter workaround worker # [ 22.512826] tailscaled[627]: wgengine: Reconfig: user dialer worker # [ 22.514317] tailscaled[627]: tsdial: bart table size: 4 worker # [ 22.515729] tailscaled[627]: wgengine: Reconfig: configuring DNS worker # [ 22.517144] tailscaled[627]: dns: Set: {DefaultResolvers:[] Routes:{tailnet.:[]}+65arpa SearchDomains:[tailnet.] Hosts:0} worker # [ 22.537696] tailscaled[627]: dns: Resolvercfg: {Routes:{.:[10.0.2.3]} Hosts:0 LocalDomains:[tailnet.]+65arpa} worker # [ 22.540573] tailscaled[627]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tailnet.] } worker # [ 22.582977] systemd[1]: Stopped target Host and Network Name Lookups. worker # [ 22.587310] systemd[1]: Stopping Host and Network Name Lookups... worker # [ 22.592168] systemd[1]: Stopped target User and Group Name Lookups. worker # [ 22.593971] systemd[1]: Stopping User and Group Name Lookups... worker # [ 22.598233] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... worker # [ 22.601396] systemd[1]: nscd.service: Deactivated successfully. worker # [ 22.603638] systemd[1]: Stopped Name Service Cache Daemon (nsncd). worker # [ 22.610298] systemd[1]: Starting Name Service Cache Daemon (nsncd)... worker # [ 22.619103] tailscaled[627]: peerapi: serving on http://100.64.0.2:46590 worker # [ 22.621768] tailscaled[627]: peerapi: serving on http://[fd7a:115c:a1e0::2]:47166 worker # [ 22.635878] nsncd[976]: Aug 31 10:18:36.421 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" worker # [ 22.641357] systemd[1]: Started Name Service Cache Daemon (nsncd). worker # [ 22.643332] systemd[1]: Reached target Host and Network Name Lookups. worker # [ 22.644742] tailscaled[627]: magicsock: home DERP changing from derp-0 [0ms] to derp-999 [0ms] (forced=false) worker # [ 22.646602] systemd[1]: Reached target User and Group Name Lookups. worker # [ 22.648618] tailscaled[627]: magicsock: home is now derp-999 () worker # [ 22.651142] tailscaled[627]: 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::7b9c:e0b5:2ee0:244c]:41641 (local) worker # [ 22.654721] tailscaled[627]: magicsock: adding connection to derp-999 for home-keep-alive worker # [ 22.656676] tailscaled[627]: magicsock: 1 active derp conns: derp-999=cr0s,wr0s worker # [ 22.658466] tailscaled[627]: updating netmap in disk cache worker # [ 22.661712] tailscaled[627]: control: NetInfo: NetInfo{varies= ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} worker # [ 22.666704] tailscaled[627]: derphttp.Client.Connect: connecting to derp-999 () worker # [ 22.673846] tailscaled[627]: tlsdial: warning: server cert for "hub" passed x509 validation but is self-signed by "CN=hub" worker # [ 22.678326] tailscaled[627]: Switching ipn state Starting -> Running (WantRunning=true, nm=true) worker # [ 22.682075] tailscaled[627]: magicsock: derp-999 connected; connGen=1 worker # [ 22.683722] tailscaled[627]: health(warnable=warming-up): ok worker: (finished: must succeed: tailscale up --login-server https://hub --auth-key hskey-auth-91l2UsdlhtJZ-42336ZcdWiCtb2A2mEFCi811P39yQbkBSbtxpyhfuPeegch0NnYe2hzRjh1uq_M3 --hostname tt-worker, in 2.20 seconds) ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/nfc5bblkf9sqhc9pgsxcf32m4a918y09-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/nfc5bblkf9sqhc9pgsxcf32m4a918y09-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 worker # [ 22.712252] tailscaled[627]: localapi: [POST] /localapi/v0/ping worker # [ 22.714252] tailscaled[627]: ping(100.64.0.1): sending disco ping to [vTAy4] hub ... worker # [ 22.719940] tailscaled[627]: magicsock: disco: node [vTAy4] d:1635487da4e53fa1 now using 192.168.1.1:41641 mtu=1360 tx=b0f4fa5b3ae5 worker # [ 22.722898] tailscaled[627]: magicsock: new contact: peer=[vTAy4] usec=13750947 cached=false via=direct worker: (finished: waiting for success: tailscale ping hub, in 0.04 seconds) hub: must succeed: tailscale ip -4 hub: (finished: must succeed: tailscale ip -4, in 0.03 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.01 seconds) hub: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub hub # [ 29.331126] systemd[1]: Starting tribuchet-hub.socket... hub # [ 29.339867] systemd[1]: Listening on tribuchet-hub.socket. hub # [ 29.344752] systemd[1]: Starting tribuchet-hub.service... hub # [ 29.397398] headscale-start[978]: 2026-08-31T10:18:36Z INF http request bytes=0 elapsed=239.182354 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49956 status=200 hub # [ 29.426952] tribuchet[1177]: 2026-08-31T10:18:36.381034Z INFO tribuchet::hub::serve: tailscale auth: TLS disabled, identity via tailscaled whois socket=/var/run/tailscale/tailscaled.sock allowed_tags=[] hub # [ 29.432847] tribuchet[1177]: 2026-08-31T10:18:36.388088Z INFO tribuchet::sd: adopted activated sockets tcp=true unix=true hub # [ 29.440369] tribuchet[1177]: 2026-08-31T10:18:36.396860Z INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock hub # [ 29.444348] systemd[1]: Started tribuchet-hub.service. worker # [ 22.918236] tailscaled[627]: control: NetInfo: NetInfo{varies=false ipv6=true ipv6os=true udp=true icmpv4=false derp=#999 portmap= link="" firewallmode="ipt-default"} hub: (finished: must succeed: systemctl start tribuchet-hub.socket tribuchet-hub, in 0.15 seconds) worker: must succeed: systemctl start tribuchet-worker worker # [ 22.938694] systemd[1]: Starting tribuchet build worker... worker # [ 23.002400] tribuchet[1012]: 2026-08-31T10:18:36.787960Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://100.64.0.1:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 23.016263] tribuchet[1012]: 2026-08-31T10:18:36.799664Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 23.021608] systemd[1]: Started tribuchet build worker. worker: (finished: must succeed: systemctl start tribuchet-worker, in 0.10 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"' worker # [ 23.029769] systemd[1]: Starting tribuchet build agent 1... worker # [ 23.051348] systemd[1]: Started tribuchet build agent 1. worker # [ 23.076515] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1018]: 2026-08-31T10:18:36.862000Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 23.081506] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1018]: 2026-08-31T10:18:36.866845Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 23.086323] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1018]: 2026-08-31T10:18:36.866879Z INFO tribuchet::worker::agent: agent listening uid=65504 hub # [ 29.625767] tailscaled[701]: magicsock: disco: node [65g7Y] d:7e30184f6e2163c2 now using 192.168.1.2:41641 mtu=1360 tx=80c980a7a569 hub # [ 29.628547] tailscaled[701]: magicsock: new contact: peer=[65g7Y] usec=19106718 cached=false via=direct hub # [ 29.643733] tribuchet[1177]: 2026-08-31T10:18:36.600212Z INFO tribuchet::hub: worker registered worker="tt-worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel", "kvm", "uid-range"] }] worker # [ 23.154854] tribuchet[1012]: 2026-08-31T10:18:36.940657Z INFO tribuchet::worker::session: connected to hub hub="http://100.64.0.1:7437" systems=["x86_64-linux"] hub # [ 29.892410] headscale-start[978]: 2026-08-31T10:18:36Z INF http request bytes=0 elapsed=490.8121 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49956 status=200 worker # [ 23.550439] tailscaled[627]: [RATELIMIT] format("control: [v\x00JSON]%d%s") hub # [ 30.393203] headscale-start[978]: 2026-08-31T10:18:37Z INF http request bytes=0 elapsed=494.634374 method=POST path=/machine/map proto=HTTP/2.0 remote=127.0.0.1:49956 status=200 hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered worker="tt-worker"', in 1.06 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.10 seconds) hub: must succeed: cat > /root/test.nix << 'EOF' let bash = builtins.storePath "/nix/store/90nk33c4fkyg4x4dfk5cykqiryf2nlqq-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/90nk33c4fkyg4x4dfk5cykqiryf2nlqq-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.02 seconds) hub: must succeed: nix-build /root/test.nix --no-out-link hub # this derivation will be built: hub # /nix/store/w0iw8gfln8v3sih53q0nq9p15bbcjzj0-tt-tailscale.drv hub # building '/nix/store/w0iw8gfln8v3sih53q0nq9p15bbcjzj0-tt-tailscale.drv'... hub # [ 30.966530] tribuchet[1177]: 2026-08-31T10:18:37.922934Z INFO tribuchet::hub::submit: queueing build id="2b163975508bec75b2b7e21d8242f716" system="x86_64-linux" hub # [ 30.970394] tribuchet[1177]: 2026-08-31T10:18:37.927066Z INFO tribuchet::hub: dispatching build id="2b163975508bec75b2b7e21d8242f716" worker="tt-worker" hub # tribuchet: building on tt-worker worker # [ 24.451899] tribuchet[1012]: 2026-08-31T10:18:38.236027Z INFO tribuchet::worker::session: build assigned id="2b163975508bec75b2b7e21d8242f716" worker # [ 24.459254] systemd[1]: Started Nix Daemon. worker # [ 24.504623] nix-daemon[1021]: accepted connection from pid 1012, user tribuchet (trusted) hub # [ 31.048651] tribuchet[1177]: 2026-08-31T10:18:38.005272Z INFO tribuchet::hub::relay::staging: input path negotiation done id="2b163975508bec75b2b7e21d8242f716" total=8 missing=1 hub # [ 31.056706] systemd[1]: Started Nix Daemon. hub # [ 31.128178] nix-daemon[1216]: accepted connection from pid 1177, user root (trusted) worker # [ 24.626574] nix-daemon[1021]: accepted connection from pid 1012, user tribuchet (trusted) worker # [ 24.637431] tribuchet[1012]: 2026-08-31T10:18:38.422946Z INFO tribuchet::worker::build::agent_exec: sandbox network decision id="2b163975508bec75b2b7e21d8242f716" fixed_output=false network=false net_isolation=false worker # [ 24.651948] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1018]: 2026-08-31T10:18:38.437156Z INFO tribuchet::worker::agent: builder started id="2b163975508bec75b2b7e21d8242f716" pid=1032 worker # [ 24.657165] tribuchet[1012]: 2026-08-31T10:18:38.437210Z INFO tribuchet::worker::build::agent_exec: builder started on agent id="2b163975508bec75b2b7e21d8242f716" pid=1032 agent=/run/tribuchet/agents/1.sock scratch=/var/lib/tribuchet/a1/scratch/1f567d4b026ed051/build worker # [ 24.668770] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1018]: 2026-08-31T10:18:38.454047Z INFO tribuchet::worker::agent: builder exited code=0 worker # [ 24.851937] tribuchet[1012]: 2026-08-31T10:18:38.637606Z INFO tribuchet::worker::build::agent_exec: builder finished id="2b163975508bec75b2b7e21d8242f716" exit_code=0 aborted=None worker # [ 24.863851] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1018]: 2026-08-31T10:18:38.649360Z INFO tribuchet::worker::agent: cleanup done id="2b163975508bec75b2b7e21d8242f716" worker # [ 24.868855] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. worker # [ 24.877167] systemd[1]: Starting tribuchet build agent 1... worker # [ 24.901974] systemd[1]: Started tribuchet build agent 1. worker # [ 24.926962] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1045]: 2026-08-31T10:18:38.712584Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 24.931710] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1045]: 2026-08-31T10:18:38.716826Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 24.935955] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1045]: 2026-08-31T10:18:38.716855Z INFO tribuchet::worker::agent: agent listening uid=65504 worker # [ 24.939337] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1045]: 2026-08-31T10:18:38.716989Z INFO tribuchet::worker::agent: no build held, exiting until the next activation worker # [ 24.943273] systemd[1]: tribuchet-agent@1.service: Deactivated successfully. worker # [ 24.958431] tribuchet[1012]: 2026-08-31T10:18:38.744080Z INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="2b163975508bec75b2b7e21d8242f716" worker # [ 24.967388] tribuchet[1012]: 2026-08-31T10:18:38.753138Z INFO tribuchet::worker::resume::delivery: build result acknowledged id="2b163975508bec75b2b7e21d8242f716" hub: (finished: must succeed: nix-build /root/test.nix --no-out-link, in 0.76 seconds) hub: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/7xp0sif0s1x7i7a7wsmibv2knmmdzy73-tt-tailscale hub: (finished: must succeed: grep -q 'tailscale-auth-payload ok' /nix/store/7xp0sif0s1x7i7a7wsmibv2knmmdzy73-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.02 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.01 seconds) (finished: subtest: a build dispatches over the tailnet, in 0.95 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 # [ 25.049156] systemd[1]: Stopping tribuchet build worker... worker # [ 25.051375] tribuchet[1012]: 2026-08-31T10:18:38.834510Z INFO tribuchet::worker: handover requested; exiting hub # [ 31.582877] tribuchet[1177]: 2026-08-31T10:18:38.539425Z INFO tribuchet::hub: worker disconnected worker="tt-worker" worker # [ 25.057582] systemd[1]: tribuchet-worker.service: Deactivated successfully. worker # [ 25.060096] systemd[1]: Stopped tribuchet build worker. worker # [ 25.061280] systemd[1]: tribuchet-worker.service: Consumed 46ms CPU time over 2.120s wall clock time, 19.3M memory peak, 17.5M read from disk, 4K written to disk, 3.2K incoming IP traffic, 2K outgoing IP traffic. worker # [ 25.068561] systemd[1]: Starting tribuchet build worker... worker # [ 25.092524] tribuchet[1062]: 2026-08-31T10:18:38.877865Z INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "http://hub:7437", auth: Tailscale, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/var/lib/tribuchet/tls/ca.crt", cert: "/var/lib/tribuchet/tls/worker.crt", key: "/var/lib/tribuchet/tls/worker.key", build_timeout_secs: 86400, max_silent_time_secs: 0, max_log_size: 0, sandbox_bin_sh: None, build_memory_max_bytes: None, max_jobs: 1, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: [], agent_sockets_dir: Some("/run/tribuchet/agents"), spawn_agents: 0, agent_uid_base: None } worker # [ 25.104589] tribuchet[1062]: 2026-08-31T10:18:38.890357Z INFO tribuchet::worker: resolved sandbox defaults fod_isolation=true bin_sh=Some("/nix/store/b3jfa39pfxlv8w0dyjb2la0q8gdw0p5v-busybox-1.37.0/bin/busybox") worker # [ 25.114423] systemd[1]: Started tribuchet build worker. worker: (finished: must succeed: systemctl restart tribuchet-worker, in 0.08 seconds) hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed' worker # [ 25.121799] systemd[1]: Starting tribuchet build agent 1... worker # [ 25.141291] systemd[1]: Started tribuchet build agent 1. worker # [ 25.163931] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1068]: 2026-08-31T10:18:38.949579Z INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325400064 uid_count=65536 worker # [ 25.168118] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1068]: 2026-08-31T10:18:38.953962Z INFO tribuchet::sd: adopted activated sockets tcp=false unix=true worker # [ 25.171712] lk1s9w1645nbqwwksa3jifbj2hzmbfs9-tribuchet-agent[1068]: 2026-08-31T10:18:38.957337Z INFO tribuchet::worker::agent: agent listening uid=65504 hub # [ 32.068398] tribuchet[1177]: 2026-08-31T10:18:39.024461Z WARN tribuchet::hub: tailscale whois failed: tailscaled whois: HTTP/1.0 404 Not Found addr=192.168.1.2:60470 worker # [ 25.545526] tribuchet[1062]: 2026-08-31T10:18:39.331200Z WARN tribuchet::worker: hub session ended: code: 'The request does not have valid authentication credentials', message: "peer is not on the tailnet" worker # [ 25.549168] tribuchet[1062]: 2026-08-31T10:18:39.331245Z INFO tribuchet::worker: reconnecting to hub in 1s worker # [ 25.716732] tailscaled[627]: magicsock: disco: node [vTAy4] d:1635487da4e53fa1 now using [2001:db8:1::1]:41641 mtu=1360 tx=52b5ea57903f hub # [ 32.246952] tailscaled[701]: magicsock: disco: node [65g7Y] d:7e30184f6e2163c2 now using [2001:db8:1::2]:41641 mtu=1360 tx=fb9d0636a509 hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'tailscale whois failed', in 1.06 seconds) (finished: subtest: a non-tailnet peer is rejected, in 1.15 seconds) (finished: run the VM test script, in 33.81 seconds) test script finished in 33.85s cleanup kill QemuMachine (pid 47) hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14) kill QemuMachine (pid 48) worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.41 seconds)