Machine state will be reset. To keep it, pass --keep-machine-state
start all VLans
(finished: start all VLans, in 0.01 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
worker # Disk image does not exist, creating the virtualisation disk image...
worker # Formatting '/build/vm-state-worker/tmp.nk62u3TLGa', fmt=raw size=8589934592
worker # mke2fs 1.47.4 (6-Mar-2025)
worker # Discarding device blocks:       0/2097152               done
worker # Creating filesystem with 2097152 4k blocks and 524288 inodes
worker # Filesystem UUID: 069a48ed-e3fd-4109-b8d3-6a0d9ac6a677
worker # Superblock backups stored on blocks:
worker # 	32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632
worker # 
worker # Allocating group tables:  0/64     done
worker # Writing inode tables:  0/64     done
worker # Creating journal (16384 blocks): done
worker # Writing superblocks and filesystem accounting information:  0/64     done
worker # 
worker # Virtualisation disk image created.
worker: QEMU running (pid 47)
worker # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)
hub: QEMU running (pid 48)
(finished: start all VMs, in 7.68 seconds)
hub: waiting for unit multi-user.target
hub: waiting for the VM to finish booting
hub # Disk image does not exist, creating the virtualisation disk image...
hub # Formatting '/build/vm-state-hub/tmp.QGqPuYYul0', fmt=raw size=4294967296
hub # mke2fs 1.47.4 (6-Mar-2025)
hub # Discarding device blocks:       0/1048576               done
hub # Creating filesystem with 1048576 4k blocks and 262144 inodes
hub # Filesystem UUID: 053c8b64-2333-4ee2-adbd-17c05cbfecf6
hub # Superblock backups stored on blocks:
hub # 	32768, 98304, 163840, 229376, 294912, 819200, 884736
hub # 
hub # Allocating group tables:  0/32     done
hub # Writing inode tables:  0/32     done
hub # Creating journal (16384 blocks): done
hub # Writing superblocks and filesystem accounting information:  0/32     done
hub # 
hub # Virtualisation disk image created.
worker # 
worker # 
worker # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFC6540+7EF26540 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 7EFC6540 7EF26540 CB00
worker # Press Ctrl-B to configure iPXE (PCI 00:08.0)...
worker # 
worker # 
hub # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)
worker # Booting from ROM...
worker # Probing EDD (edd=off to disable)... ok
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...
worker # [    0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 23 12:27:10 UTC 2026
worker # [    0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/j51r5d2d407894f465jsqbira27yqshb-nixos-system-worker-test/init regInfo=/nix/store/l6vlm1gpn7bj33bias66jr0yy6v7rkrc-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-0x000000007ffd7fff] usable
worker # [    0.000000] BIOS-e820: [mem 0x000000007ffd8000-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 0x0000000100000000-0x000000017fffffff] usable
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
hub # Probing EDD (edd=off to disable)... ok[    0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sun Aug 23 12:27:10 UTC 2026
worker # [    0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000
worker # [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
worker # [    0.000001] kvm-clock: using sched offset of 2381438035 cycles
worker # [    0.000004] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
worker # [    0.000008] tsc: Detected 3099.998 MHz processor
worker # [    0.000999] last_pfn = 0x180000 max_arch_pfn = 0x400000000
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/0zr0mac8vpixj4gbcazcpnpd335lfgdj-nixos-system-hub-test/init regInfo=/nix/store/z6igc6bmpfv5mqfdc5v17l5vspvlh3r8-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.
worker # [    0.001031] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
worker # [    0.001034] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT
worker # [    0.001093] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000
hub # [    0.000000] BIOS-provided physical RAM map:
hub # [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
worker # [    0.003345] found SMP MP-table at [mem 0x000f5450-0x000f545f]
worker # [    0.003369] Using GB pages for direct mapping
hub # [    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
hub # [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
worker # [    0.003442] RAMDISK: [mem 0x7e36e000-0x7ffcffff]
hub # [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffd7fff] usable
worker # [    0.003451] ACPI: Early table checksum verification disabled
worker # [    0.003455] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS )
worker # [    0.003460] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
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
worker # [    0.003466] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
worker # [    0.003474] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
hub # [    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
worker # [    0.003477] ACPI: FACS 0x000000007FFE0000 000040
hub # [    0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
worker # [    0.003479] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.000000] NX (Execute Disable) protection: active
hub # [    0.000000] APIC: Static calls initialized
worker # [    0.003482] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.000000] SMBIOS 2.8 present.
worker # [    0.003484] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS  BXPC     00000001 BXPC 00000001)
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
worker # [    0.003486] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.000000] Hypervisor detected: KVM
hub # [    0.000000] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000
worker # [    0.003488] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d]
hub # [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
worker # [    0.003490] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219]
worker # [    0.003490] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]
hub # [    0.000001] kvm-clock: using sched offset of 1920511373 cycles
hub # [    0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
hub # [    0.000007] tsc: Detected 3099.998 MHz processor
worker # [    0.003491] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385]
hub # [    0.004875] last_pfn = 0x7ffd8 max_arch_pfn = 0x400000000
hub # [    0.004907] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
worker # [    0.003492] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd]
worker # [    0.003492] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9]
hub # [    0.004911] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT
hub # [    0.022747] found SMP MP-table at [mem 0x000f5450-0x000f545f]
worker # [    0.003493] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421]
worker # [    0.003969] No NUMA configuration found
hub # [    0.022780] Using GB pages for direct mapping
hub # [    0.022955] RAMDISK: [mem 0x7e36f000-0x7ffcffff]
hub # [    0.022968] ACPI: Early table checksum verification disabled
worker # [    0.003971] Faking a node at [mem 0x0000000000000000-0x000000017fffffff]
worker # [    0.003974] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff]
worker # [    0.004091] Zone ranges:
hub # [    0.022974] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )
hub # [    0.022979] ACPI: RSDT 0x000000007FFE2422 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
worker # [    0.004092]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
worker # [    0.004094]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
worker # [    0.004096]   Normal   [mem 0x0000000100000000-0x000000017fffffff]
hub # [    0.022986] ACPI: FACP 0x000000007FFE221A 0000F4 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.022994] ACPI: DSDT 0x000000007FFE0040 0021DA (v01 BOCHS  BXPC     00000001 BXPC 00000001)
worker # [    0.004097]   Device   empty
hub # [    0.022998] ACPI: FACS 0x000000007FFE0000 000040
worker # [    0.004098] Movable zone start for each node
worker # [    0.004098] Early memory node ranges
hub # [    0.023000] ACPI: APIC 0x000000007FFE230E 000078 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
worker # [    0.004099]   node   0: [mem 0x0000000000001000-0x000000000009efff]
worker # [    0.004101]   node   0: [mem 0x0000000000100000-0x000000007ffd7fff]
hub # [    0.023009] ACPI: HPET 0x000000007FFE2386 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.023012] ACPI: MCFG 0x000000007FFE23BE 00003C (v01 BOCHS  BXPC     00000001 BXPC 00000001)
worker # [    0.004102]   node   0: [mem 0x0000000100000000-0x000000017fffffff]
worker # [    0.004103] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff]
hub # [    0.023014] ACPI: WAET 0x000000007FFE23FA 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)
hub # [    0.023017] ACPI: Reserving FACP table memory at [mem 0x7ffe221a-0x7ffe230d]
worker # [    0.004129] On node 0, zone DMA: 1 pages in unavailable ranges
worker # [    0.004412] On node 0, zone DMA: 97 pages in unavailable ranges
hub # [    0.023018] ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe2219]
hub # [    0.023019] ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f]
worker # [    0.142158] On node 0, zone Normal: 40 pages in unavailable ranges
hub # [    0.023020] ACPI: Reserving APIC table memory at [mem 0x7ffe230e-0x7ffe2385]
worker # [    0.143238] ACPI: PM-Timer IO Port: 0x608
worker # [    0.143258] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
worker # [    0.143293] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
hub # [    0.023021] ACPI: Reserving HPET table memory at [mem 0x7ffe2386-0x7ffe23bd]
hub # [    0.023021] ACPI: Reserving MCFG table memory at [mem 0x7ffe23be-0x7ffe23f9]
worker # [    0.143297] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
hub # [    0.023022] ACPI: Reserving WAET table memory at [mem 0x7ffe23fa-0x7ffe2421]
hub # [    0.023731] No NUMA configuration found
worker # [    0.143299] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
hub # [    0.023734] Faking a node at [mem 0x0000000000000000-0x000000007ffd7fff]
worker # [    0.143300] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
worker # [    0.143301] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
hub # [    0.023738] NODE_DATA(0) allocated [mem 0x7ffd2780-0x7ffd7cff]
hub # [    0.024143] Zone ranges:
hub # [    0.024144]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
worker # [    0.143302] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
hub # [    0.024146]   DMA32    [mem 0x0000000001000000-0x000000007ffd7fff]
hub # [    0.024148]   Normal   empty
worker # [    0.143306] ACPI: Using ACPI (MADT) for SMP configuration information
worker # [    0.143307] ACPI: HPET id: 0x8086a201 base: 0xfed00000
hub # [    0.024149]   Device   empty
hub # [    0.024149] Movable zone start for each node
hub # [    0.024150] Early memory node ranges
worker # [    0.143314] TSC deadline timer available
worker # [    0.143320] CPU topo: Max. logical packages:   1
hub # [    0.024150]   node   0: [mem 0x0000000000001000-0x000000000009efff]
hub # [    0.024152]   node   0: [mem 0x0000000000100000-0x000000007ffd7fff]
worker # [    0.143321] CPU topo: Max. logical dies:       1
worker # [    0.143321] CPU topo: Max. dies per package:   1
worker # [    0.143325] CPU topo: Max. threads per core:   1
hub # [    0.024154] Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffd7fff]
hub # [    0.024177] On node 0, zone DMA: 1 pages in unavailable ranges
worker # [    0.143326] CPU topo: Num. cores per package:     1
worker # [    0.143327] CPU topo: Num. threads per package:   1
hub # [    0.055664] On node 0, zone DMA: 97 pages in unavailable ranges
hub # [    0.197759] On node 0, zone DMA32: 40 pages in unavailable ranges
worker # [    0.143327] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs
hub # [    0.198775] ACPI: PM-Timer IO Port: 0x608
worker # [    0.143354] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
hub # [    0.198793] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
hub # [    0.198822] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
worker # [    0.143390] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
worker # [    0.143392] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
hub # [    0.198825] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
hub # [    0.198827] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
worker # [    0.143394] PM: hibernation: Registered nosave memory: [mem 0x7ffd8000-0xffffffff]
worker # [    0.143396] [mem 0xc0000000-0xfed1bfff] available for PCI devices
hub # [    0.198829] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
hub # [    0.198830] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
worker # [    0.143402] Booting paravirtualized kernel on KVM
worker # [    0.143410] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
hub # [    0.198831] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
hub # [    0.198834] ACPI: Using ACPI (MADT) for SMP configuration information
hub # [    0.198835] ACPI: HPET id: 0x8086a201 base: 0xfed00000
worker # [    0.148608] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
worker # [    0.151447] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152
hub # [    0.198843] TSC deadline timer available
hub # [    0.198851] CPU topo: Max. logical packages:   1
worker # [    0.151510] kvm-guest: PV spinlocks disabled, single CPU
hub # [    0.198852] CPU topo: Max. logical dies:       1
hub # [    0.198852] CPU topo: Max. dies per package:   1
hub # [    0.198857] CPU topo: Max. threads per core:   1
hub # [    0.198860] CPU topo: Num. cores per package:     1
hub # [    0.198860] CPU topo: Num. threads per package:   1
hub # [    0.198861] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs
worker # [    0.151513] 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/j51r5d2d407894f465jsqbira27yqshb-nixos-system-worker-test/init regInfo=/nix/store/l6vlm1gpn7bj33bias66jr0yy6v7rkrc-closure-info/registration console=ttyS0,115200n8 console=tty0
hub # [    0.198887] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
hub # [    0.198931] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
worker # [    0.151638] Unknown kernel command line parameters "regInfo=/nix/store/l6vlm1gpn7bj33bias66jr0yy6v7rkrc-closure-info/registration", will be passed to user space.
hub # [    0.198933] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
worker # [    0.151660] random: crng init done
hub # [    0.198935] [mem 0xc0000000-0xfed1bfff] available for PCI devices
worker # [    0.151660] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes
hub # [    0.198937] Booting paravirtualized kernel on KVM
worker # [    0.158128] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
hub # [    0.198941] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
worker # [    0.161195] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
worker # [    0.161253] software IO TLB: area num 1.
hub # [    0.204558] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
hub # [    0.207147] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152
worker # [    0.262504] Fallback order for Node 0: 0
worker # [    0.262521] Built 1 zonelists, mobility grouping on.  Total pages: 1048438
worker # [    0.262524] Policy zone: Normal
hub # [    0.207205] kvm-guest: PV spinlocks disabled, single CPU
worker # [    0.266838] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
worker # [    0.284569] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
worker # [    0.297601] allocated 8388608 bytes of page_ext
worker # [    0.312030] ftrace: allocating 48731 entries in 192 pages
worker # [    0.312035] ftrace: allocated 192 pages with 2 groups
worker # [    0.313048] Dynamic Preempt: lazy
hub # [    0.207207] 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/0zr0mac8vpixj4gbcazcpnpd335lfgdj-nixos-system-hub-test/init regInfo=/nix/store/z6igc6bmpfv5mqfdc5v17l5vspvlh3r8-closure-info/registration console=ttyS0,115200n8 console=tty0
worker # [    0.313264] rcu: Preemptible hierarchical RCU implementation.
worker # [    0.313265] rcu: 	RCU event tracing is enabled.
hub # [    0.207336] Unknown kernel command line parameters "regInfo=/nix/store/z6igc6bmpfv5mqfdc5v17l5vspvlh3r8-closure-info/registration", will be passed to user space.
hub # [    0.207357] random: crng init done
worker # [    0.313265] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
worker # [    0.313267] 	Trampoline variant of Tasks RCU enabled.
hub # [    0.207358] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes
worker # [    0.313269] 	Rude variant of Tasks RCU enabled.
worker # [    0.313270] 	Tracing variant of Tasks RCU enabled.
hub # [    0.215920] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
hub # [    0.217152] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
hub # [    0.217198] Fallback order for Node 0: 0
worker # [    0.313273] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
worker # [    0.313274] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
hub # [    0.217203] Built 1 zonelists, mobility grouping on.  Total pages: 524150
worker # [    0.313305] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
hub # [    0.217204] Policy zone: DMA32
hub # [    0.226260] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
worker # [    0.313306] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
hub # [    0.243195] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
hub # [    0.248842] allocated 4194304 bytes of page_ext
worker # [    0.313307] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
worker # [    0.320052] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
hub # [    0.260461] ftrace: allocating 48731 entries in 192 pages
hub # [    0.260466] ftrace: allocated 192 pages with 2 groups
hub # [    0.261524] Dynamic Preempt: lazy
hub # [    0.261752] rcu: Preemptible hierarchical RCU implementation.
worker # [    0.320391] rcu: srcu_init: Setting srcu_struct sizes based on contention.
hub # [    0.261752] rcu: 	RCU event tracing is enabled.
worker # [    0.320513] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
hub # [    0.261753] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
worker # [    0.320865] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
worker # [    0.329912] Console: colour VGA+ 80x25
hub # [    0.261755] 	Trampoline variant of Tasks RCU enabled.
hub # [    0.261755] 	Rude variant of Tasks RCU enabled.
worker # [    0.329925] printk: legacy console [tty0] enabled
worker # [    0.385612] printk: legacy console [ttyS0] enabled
hub # [    0.261755] 	Tracing variant of Tasks RCU enabled.
hub # [    0.261757] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
worker # [    0.567982] ACPI: Core revision 20250807
hub # [    0.261757] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
worker # [    0.569370] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
hub # [    0.261785] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
worker # [    0.572018] APIC: Switch to symmetric I/O mode setup
hub # [    0.261787] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
worker # [    0.573420] x2apic enabled
hub # [    0.261788] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
hub # [    0.271171] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
worker # [    0.575299] APIC: Switched APIC routing to: physical x2apic
hub # [    0.271774] rcu: srcu_init: Setting srcu_struct sizes based on contention.
hub # [    0.271784] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
worker # [    0.578454] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
hub # [    0.271912] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
hub # [    0.284010] Console: colour VGA+ 80x25
worker # [    0.580380] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns
hub # [    0.284018] printk: legacy console [tty0] enabled
hub # [    0.346956] printk: legacy console [ttyS0] enabled
hub # [    0.516079] ACPI: Core revision 20250807
worker # [    0.583339] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998)
worker # [    0.585428] x86/cpu: User Mode Instruction Prevention (UMIP) activated
hub # [    0.517576] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
worker # [    0.587395] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
hub # [    0.519913] APIC: Switch to symmetric I/O mode setup
hub # [    0.521367] x2apic enabled
worker # [    0.589335] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
hub # [    0.522541] APIC: Switched APIC routing to: physical x2apic
hub # [    0.525095] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
hub # [    0.526603] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns
worker # [    0.590343] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto
hub # [    0.529102] Calibrating delay loop (skipped) preset value.. 6199.99 BogoMIPS (lpj=3099998)
hub # [    0.530182] x86/cpu: User Mode Instruction Prevention (UMIP) activated
worker # [    0.592340] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
hub # [    0.531230] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
worker # [    0.594336] Spectre V2 : Mitigation: Retpolines
worker # [    0.595335] RETBleed: Mitigation: untrained return thunk
hub # [    0.532097] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
worker # [    0.596344] Speculative Return Stack Overflow: Mitigation: SMT disabled
hub # [    0.534100] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto
worker # [    0.598332] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
hub # [    0.535097] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
hub # [    0.536097] Spectre V2 : Mitigation: Retpolines
worker # [    0.599336] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
hub # [    0.537981] RETBleed: Mitigation: untrained return thunk
worker # [    0.600335] Spectre V2 : Enabling Speculation Barrier for firmware calls
worker # [    0.602336] active return thunk: retbleed_return_thunk
hub # [    0.538097] Speculative Return Stack Overflow: Mitigation: SMT disabled
worker # [    0.604339] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
hub # [    0.540097] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
hub # [    0.542097] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
worker # [    0.605353] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
hub # [    0.543097] Spectre V2 : Enabling Speculation Barrier for firmware calls
worker # [    0.606332] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
worker # [    0.607344] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
hub # [    0.544097] active return thunk: retbleed_return_thunk
hub # [    0.545098] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
worker # [    0.609336] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
hub # [    0.546109] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
worker # [    0.610336] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.
hub # [    0.547097] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
hub # [    0.548097] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
hub # [    0.549097] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
hub # [    0.551097] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.
worker # [    0.640158] Freeing SMP alternatives memory: 44K
worker # [    0.640332] pid_max: default: 32768 minimum: 301
hub # [    0.578052] Freeing SMP alternatives memory: 44K
worker # [    0.641668] LSM: initializing lsm=capability,landlock,yama,bpf,ima
worker # [    0.643444] landlock: Up and running.
hub # [    0.578998] pid_max: default: 32768 minimum: 301
hub # [    0.580188] LSM: initializing lsm=capability,landlock,yama,bpf,ima
worker # [    0.645032] Yama: becoming mindful.
hub # [    0.582186] landlock: Up and running.
hub # [    0.583096] Yama: becoming mindful.
worker # [    0.646174] LSM support for eBPF active
hub # [    0.584918] LSM support for eBPF active
worker # [    0.647618] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
hub # [    0.586202] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
worker # [    0.649419] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
hub # [    0.587138] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
hub # [    0.589958] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0)
worker # [    0.652634] smpboot: CPU0: AMD Ryzen 9 3900 12-Core Processor (family: 0x17, model: 0x71, stepping: 0x0)
hub # [    0.590560] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
worker # [    0.653987] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
hub # [    0.591100] ... version:                   0
worker # [    0.655340] ... version:                   0
hub # [    0.592099] ... bit width:                 48
worker # [    0.656347] ... bit width:                 48
hub # [    0.593143] ... generic counters:          6
hub # [    0.594098] ... generic bitmap:            000000000000003f
worker # [    0.657336] ... generic counters:          6
hub # [    0.595098] ... fixed-purpose counters:    0
worker # [    0.658336] ... generic bitmap:            000000000000003f
worker # [    0.659338] ... fixed-purpose counters:    0
hub # [    0.596098] ... fixed-purpose bitmap:      0000000000000000
hub # [    0.597098] ... value mask:                0000ffffffffffff
worker # [    0.660336] ... fixed-purpose bitmap:      0000000000000000
hub # [    0.598098] ... max period:                00007fffffffffff
hub # [    0.599098] ... global_ctrl mask:          000000000000003f
worker # [    0.661336] ... value mask:                0000ffffffffffff
worker # [    0.662337] ... max period:                00007fffffffffff
hub # [    0.600189] signal: max sigframe size: 1776
worker # [    0.663336] ... global_ctrl mask:          000000000000003f
hub # [    0.601478] rcu: Hierarchical SRCU implementation.
hub # [    0.602101] rcu: 	Max phase no-delay instances is 400.
worker # [    0.664465] signal: max sigframe size: 1776
worker # [    0.665486] rcu: Hierarchical SRCU implementation.
worker # [    0.666340] rcu: 	Max phase no-delay instances is 400.
hub # [    0.607234] smp: Bringing up secondary CPUs ...
hub # [    0.608111] smp: Brought up 1 node, 1 CPU
hub # [    0.609101] smpboot: Total of 1 processors activated (6199.99 BogoMIPS)
worker # [    0.672651] smp: Bringing up secondary CPUs ...
worker # [    0.673354] smp: Brought up 1 node, 1 CPU
hub # [    0.610326] Memory: 1971620K/2096600K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 115488K reserved, 0K cma-reserved)
worker # [    0.674340] smpboot: Total of 1 processors activated (6199.99 BogoMIPS)
hub # [    0.611477] devtmpfs: initialized
hub # [    0.612267] x86/mm: Memory block size: 128MB
worker # [    0.675642] Memory: 3962392K/4193752K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 217636K reserved, 0K cma-reserved)
hub # [    0.614013] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
hub # [    0.615129] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
worker # [    0.677983] devtmpfs: initialized
hub # [    0.616180] pinctrl core: initialized pinctrl subsystem
worker # [    0.679331] x86/mm: Memory block size: 128MB
hub # [    0.617464] PM: RTC time: 18:03:51, date: 2026-08-30
worker # [    0.681713] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
worker # [    0.682369] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
hub # [    0.621130] NET: Registered PF_NETLINK/PF_ROUTE protocol family
worker # [    0.683484] pinctrl core: initialized pinctrl subsystem
hub # [    0.622581] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
worker # [    0.684633] PM: RTC time: 18:03:52, date: 2026-08-30
hub # [    0.623137] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
hub # [    0.624396] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
worker # [    0.688345] NET: Registered PF_NETLINK/PF_ROUTE protocol family
hub # [    0.625119] audit: initializing netlink subsys (disabled)
worker # [    0.690122] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
hub # [    0.626648] thermal_sys: Registered thermal governor 'fair_share'
worker # [    0.691410] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
hub # [    0.626650] thermal_sys: Registered thermal governor 'bang_bang'
hub # [    0.627102] audit: type=2000 audit(1788113032.204:1): state=initialized audit_enabled=0 res=1
worker # [    0.693083] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
hub # [    0.629100] thermal_sys: Registered thermal governor 'step_wise'
hub # [    0.629102] thermal_sys: Registered thermal governor 'user_space'
worker # [    0.694374] audit: initializing netlink subsys (disabled)
hub # [    0.630098] thermal_sys: Registered thermal governor 'power_allocator'
hub # [    0.631158] cpuidle: using governor menu
worker # [    0.695955] thermal_sys: Registered thermal governor 'fair_share'
worker # [    0.695957] thermal_sys: Registered thermal governor 'bang_bang'
hub # [    0.634313] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
worker # [    0.696337] thermal_sys: Registered thermal governor 'step_wise'
hub # [    0.635481] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]
worker # [    0.697337] thermal_sys: Registered thermal governor 'user_space'
hub # [    0.636100] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry
worker # [    0.698346] audit: type=2000 audit(1788113032.199:1): state=initialized audit_enabled=0 res=1
worker # [    0.700348] thermal_sys: Registered thermal governor 'power_allocator'
hub # [    0.637116] PCI: Using configuration type 1 for base access
worker # [    0.700385] cpuidle: using governor menu
hub # [    0.638308] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
worker # [    0.703555] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
worker # [    0.704661] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]
worker # [    0.705340] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry
hub # [    0.645127] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
worker # [    0.706356] PCI: Using configuration type 1 for base access
hub # [    0.646098] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
worker # [    0.707553] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
hub # [    0.651098] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
hub # [    0.652099] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
worker # [    0.713695] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
worker # [    0.714339] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
worker # [    0.715345] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
worker # [    0.716337] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
hub # [    0.660510] ACPI: Added _OSI(Module Device)
hub # [    0.661099] ACPI: Added _OSI(Processor Device)
hub # [    0.666098] ACPI: Added _OSI(Processor Aggregator Device)
worker # [    0.729296] ACPI: Added _OSI(Module Device)
worker # [    0.730227] ACPI: Added _OSI(Processor Device)
hub # [    0.673011] ACPI: 1 ACPI AML tables successfully acquired and loaded
worker # [    0.731279] ACPI: Added _OSI(Processor Aggregator Device)
hub # [    0.681404] ACPI: Interpreter enabled
hub # [    0.682120] ACPI: PM: (supports S0 S3 S4 S5)
worker # [    0.742178] ACPI: 1 ACPI AML tables successfully acquired and loaded
hub # [    0.683100] ACPI: Using IOAPIC for interrupt routing
hub # [    0.684141] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
hub # [    0.685099] PCI: Using E820 reservations for host bridge windows
hub # [    0.686213] ACPI: Enabled 2 GPEs in block 00 to 3F
worker # [    0.751685] ACPI: Interpreter enabled
worker # [    0.752354] ACPI: PM: (supports S0 S3 S4 S5)
worker # [    0.755339] ACPI: Using IOAPIC for interrupt routing
worker # [    0.756477] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
worker # [    0.759345] PCI: Using E820 reservations for host bridge windows
worker # [    0.760524] ACPI: Enabled 2 GPEs in block 00 to 3F
hub # [    0.697165] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
hub # [    0.698105] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
hub # [    0.699152] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]
worker # [    0.766798] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
hub # [    0.700187] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]
worker # [    0.767347] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
worker # [    0.768438] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]
hub # [    0.703151] PCI host bridge to bus 0000:00
worker # [    0.769433] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]
hub # [    0.704105] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
worker # [    0.770918] PCI host bridge to bus 0000:00
hub # [    0.705099] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
worker # [    0.771344] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
hub # [    0.706099] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
worker # [    0.772339] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
hub # [    0.707099] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]
worker # [    0.773338] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
hub # [    0.708099] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
worker # [    0.774338] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]
hub # [    0.709099] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]
worker # [    0.775339] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
hub # [    0.710099] pci_bus 0000:00: root bus resource [bus 00-ff]
worker # [    0.776337] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window]
worker # [    0.777342] pci_bus 0000:00: root bus resource [bus 00-ff]
hub # [    0.711322] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint
worker # [    0.778507] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint
hub # [    0.713098] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint
worker # [    0.780486] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint
hub # [    0.716180] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]
hub # [    0.717238] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]
hub # [    0.718145] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]
worker # [    0.783416] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]
worker # [    0.784364] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]
hub # [    0.719607] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
worker # [    0.785385] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]
worker # [    0.786604] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
hub # [    0.721073] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
worker # [    0.788587] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
hub # [    0.724111] pci 0000:00:02.0: BAR 0 [io  0xc140-0xc15f]
hub # [    0.725228] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]
hub # [    0.726146] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]
hub # [    0.727111] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]
worker # [    0.791359] pci 0000:00:02.0: BAR 0 [io  0xc140-0xc15f]
hub # [    0.729456] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
worker # [    0.793498] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]
worker # [    0.794388] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref]
worker # [    0.795351] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]
hub # [    0.733111] pci 0000:00:03.0: BAR 0 [io  0xc160-0xc17f]
hub # [    0.734112] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]
worker # [    0.797623] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
hub # [    0.735154] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]
hub # [    0.737634] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
worker # [    0.800354] pci 0000:00:03.0: BAR 0 [io  0xc160-0xc17f]
worker # [    0.801352] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]
hub # [    0.740111] pci 0000:00:04.0: BAR 0 [io  0xc080-0xc0bf]
worker # [    0.802388] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref]
hub # [    0.741111] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]
hub # [    0.742145] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]
worker # [    0.805341] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
hub # [    0.744285] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
worker # [    0.808354] pci 0000:00:04.0: BAR 0 [io  0xc080-0xc0bf]
hub # [    0.747111] pci 0000:00:05.0: BAR 0 [io  0xc180-0xc19f]
hub # [    0.748112] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]
worker # [    0.809352] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]
worker # [    0.810395] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref]
hub # [    0.749146] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]
worker # [    0.812916] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
hub # [    0.751623] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
hub # [    0.754111] pci 0000:00:06.0: BAR 0 [io  0xc1a0-0xc1bf]
worker # [    0.816521] pci 0000:00:05.0: BAR 0 [io  0xc180-0xc19f]
hub # [    0.755111] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]
hub # [    0.756158] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]
worker # [    0.817350] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]
worker # [    0.819389] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref]
hub # [    0.758726] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
worker # [    0.822466] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
hub # [    0.762111] pci 0000:00:07.0: BAR 0 [io  0xc000-0xc07f]
hub # [    0.763114] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]
worker # [    0.825638] pci 0000:00:06.0: BAR 0 [io  0xc1a0-0xc1bf]
worker # [    0.826351] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]
hub # [    0.764285] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]
worker # [    0.827384] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref]
hub # [    0.766450] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
hub # [    0.769116] pci 0000:00:08.0: BAR 0 [io  0xc1c0-0xc1df]
hub # [    0.770114] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]
hub # [    0.771149] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]
hub # [    0.772113] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]
hub # [    0.774467] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
hub # [    0.777128] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]
hub # [    0.778159] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]
hub # [    0.780748] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
worker # [    0.831049] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
hub # [    0.785116] pci 0000:00:0a.0: BAR 0 [io  0xc0c0-0xc0ff]
hub # [    0.786113] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]
hub # [    0.787155] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]
worker # [    0.834404] pci 0000:00:07.0: BAR 0 [io  0xc000-0xc07f]
worker # [    0.835352] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]
worker # [    0.836387] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref]
hub # [    0.789578] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
worker # [    0.838530] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
hub # [    0.792112] pci 0000:00:0b.0: BAR 0 [io  0xc1e0-0xc1ff]
hub # [    0.793112] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]
worker # [    0.842186] pci 0000:00:08.0: BAR 0 [io  0xc1c0-0xc1df]
hub # [    0.794146] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]
worker # [    0.843351] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]
worker # [    0.844386] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref]
worker # [    0.845351] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]
hub # [    0.796915] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint
hub # [    0.799595] pci 0000:00:1d.0: BAR 4 [io  0xc200-0xc21f]
hub # [    0.801600] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint
worker # [    0.847508] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
hub # [    0.803540] pci 0000:00:1d.1: BAR 4 [io  0xc220-0xc23f]
hub # [    0.804614] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint
hub # [    0.807360] pci 0000:00:1d.2: BAR 4 [io  0xc240-0xc25f]
worker # [    0.851361] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]
worker # [    0.852402] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref]
hub # [    0.808673] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint
worker # [    0.855657] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
hub # [    0.811111] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]
hub # [    0.813562] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint
hub # [    0.816040] pci 0000:00:1f.0: quirk: [io  0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO
hub # [    0.817933] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint
hub # [    0.821202] pci 0000:00:1f.2: BAR 4 [io  0xc260-0xc27f]
hub # [    0.822116] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]
hub # [    0.824114] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint
hub # [    0.827178] pci 0000:00:1f.3: BAR 4 [io  0x0700-0x073f]
hub # [    0.835755] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
hub # [    0.837245] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
hub # [    0.838286] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
hub # [    0.839232] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
hub # [    0.840266] ACPI: PCI: Interrupt link LNKE configured for IRQ 10
hub # [    0.841228] ACPI: PCI: Interrupt link LNKF configured for IRQ 10
hub # [    0.844319] ACPI: PCI: Interrupt link LNKG configured for IRQ 11
hub # [    0.845236] ACPI: PCI: Interrupt link LNKH configured for IRQ 11
hub # [    0.846160] ACPI: PCI: Interrupt link GSIA configured for IRQ 16
hub # [    0.847546] ACPI: PCI: Interrupt link GSIB configured for IRQ 17
hub # [    0.848141] ACPI: PCI: Interrupt link GSIC configured for IRQ 18
hub # [    0.849122] ACPI: PCI: Interrupt link GSID configured for IRQ 19
hub # [    0.850135] ACPI: PCI: Interrupt link GSIE configured for IRQ 20
hub # [    0.851133] ACPI: PCI: Interrupt link GSIF configured for IRQ 21
hub # [    0.853231] ACPI: PCI: Interrupt link GSIG configured for IRQ 22
hub # [    0.854272] ACPI: PCI: Interrupt link GSIH configured for IRQ 23
hub # [    0.857268] iommu: Default domain type: Translated
hub # [    0.858108] iommu: DMA domain TLB invalidation policy: lazy mode
hub # [    0.859424] ACPI: bus type USB registered
hub # [    0.860175] usbcore: registered new interface driver usbfs
hub # [    0.861121] usbcore: registered new interface driver hub
hub # [    0.862116] usbcore: registered new device driver usb
hub # [    0.864760] NetLabel: Initializing
hub # [    0.865885] NetLabel:  domain hash size = 128
hub # [    0.867099] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
hub # [    0.868155] NetLabel:  unlabeled traffic allowed by default
hub # [    0.869112] PCI: Using ACPI for IRQ routing
worker # [    0.860375] pci 0000:00:0a.0: BAR 0 [io  0xc0c0-0xc0ff]
worker # [    0.862387] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]
worker # [    0.864479] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref]
hub # [    1.005998] pci 0000:00:01.0: vgaarb: setting as boot VGA device
hub # [    1.006094] pci 0000:00:01.0: vgaarb: bridge control possible
hub # [    1.006094] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
hub # [    1.006131] vgaarb: loaded
hub # [    1.007473] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
hub # [    1.008099] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
hub # [    1.012302] clocksource: Switched to clocksource kvm-clock
hub # [    1.018057] VFS: Disk quotas dquot_6.6.0
hub # [    1.021265] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
hub # [    1.024298] pnp: PnP ACPI init
hub # [    1.025963] ACPI: IRQ 4 override to edge(!), high(!)
hub # [    1.033686] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved
hub # [    1.037095] pnp: PnP ACPI: found 6 devices
hub # [    1.046634] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
hub # [    1.049285] clocksource: Switched to clocksource acpi_pm
hub # [    1.051694] NET: Registered PF_INET protocol family
hub # [    1.054909] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
worker # [    0.870837] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
worker # [    0.875391] pci 0000:00:0b.0: BAR 0 [io  0xc1e0-0xc1ff]
hub # [    1.087820] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)
worker # [    0.876778] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]
hub # [    1.091785] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
hub # [    1.094884] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)
hub # [    1.097349] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)
hub # [    1.100276] TCP: Hash tables configured (established 16384 bind 16384)
hub # [    1.102819] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)
worker # [    0.877410] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref]
hub # [    1.105646] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)
hub # [    1.108553] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)
hub # [    1.112627] NET: Registered PF_UNIX/PF_LOCAL protocol family
hub # [    1.115790] NET: Registered PF_XDP protocol family
hub # [    1.119160] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
hub # [    1.121102] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
hub # [    1.123069] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
hub # [    1.125285] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]
worker # [    0.880805] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint
hub # [    1.127952] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]
hub # [    1.130045] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]
hub # [    1.136684] ACPI: \_SB_.GSIA: Enabled at IRQ 16
hub # [    1.140156] ACPI: \_SB_.GSIB: Enabled at IRQ 17
hub # [    1.145814] ACPI: \_SB_.GSIC: Enabled at IRQ 18
hub # [    1.159173] pci 0000:00:1d.2: quirk_usb_early_handoff+0x0/0x7c0 took 14147 usecs
hub # [    1.172087] ACPI: \_SB_.GSID: Enabled at IRQ 19
hub # [    1.177142] PCI: CLS 0 bytes, default 64
hub # [    1.182703] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns
hub # [    1.190684] Trying to unpack rootfs image as initramfs...
hub # [    1.272050] Initialise system trusted keyrings
hub # [    1.276708] workingset: timestamp_bits=40 max_order=19 bucket_order=0
worker # [    0.885427] pci 0000:00:1d.0: BAR 4 [io  0xc200-0xc21f]
hub # [    1.319028] Key type asymmetric registered
hub # [    1.373016] Asymmetric key parser 'x509' registered
hub # [    1.374753] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
hub # [    1.389590] io scheduler mq-deadline registered
hub # [    1.391066] io scheduler kyber registered
hub # [    1.393409] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
hub # [    1.395779] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
hub # [    1.403134] Linux agpgart interface v0.103
hub # [    1.404607] ACPI: bus type drm_connector registered
hub # [    1.409546] usbcore: registered new interface driver usbserial_generic
hub # [    1.413973] usbserial: USB Serial support registered for generic
hub # [    1.415818] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
hub # [    1.419598] drop_monitor: Initializing network drop monitor service
hub # [    1.421699] NET: Registered PF_INET6 protocol family
hub # [    1.424625] Segment Routing with IPv6
hub # [    1.425854] In-situ OAM (IOAM) with IPv6
hub # [    1.428032] IPI shorthand broadcast: enabled
hub # [    1.448064] sched_clock: Marking stable (1195030898, 252311203)->(1732490749, -285148648)
hub # [    1.452623] registered taskstats version 1
hub # [    1.459089] Loading compiled-in X.509 certificates
hub # [    1.496741] Demotion targets for Node 0: null
hub # [    1.522991] Key type .fscrypt registered
hub # [    1.527351] Key type fscrypt-provisioning registered
hub # [    1.529754] ima: No TPM chip found, activating TPM-bypass!
hub # [    1.544365] ima: Allocated hash algorithm: sha1
hub # [    1.546787] ima: No architecture policies found
hub # [    1.554612] PM:   Magic number: 6:690:90
hub # [    1.565142] RAS: Correctable Errors collector initialized.
hub # [    1.586909] clk: Disabling unused clocks
hub # [    1.593434] PM: genpd: Disabling unused power domains
worker # [    0.891208] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint
worker # [    0.895406] pci 0000:00:1d.1: BAR 4 [io  0xc220-0xc23f]
worker # [    0.897882] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint
worker # [    0.901166] pci 0000:00:1d.2: BAR 4 [io  0xc240-0xc25f]
worker # [    0.902890] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint
worker # [    0.906683] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]
worker # [    0.907840] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint
worker # [    0.911543] pci 0000:00:1f.0: quirk: [io  0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO
worker # [    0.914884] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint
worker # [    0.918640] pci 0000:00:1f.2: BAR 4 [io  0xc260-0xc27f]
worker # [    0.919351] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]
worker # [    0.922672] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint
worker # [    0.924979] pci 0000:00:1f.3: BAR 4 [io  0x0700-0x073f]
worker # [    0.934834] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
worker # [    0.936016] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
worker # [    0.937463] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
worker # [    0.938466] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
worker # [    0.939619] ACPI: PCI: Interrupt link LNKE configured for IRQ 10
worker # [    0.940466] ACPI: PCI: Interrupt link LNKF configured for IRQ 10
worker # [    0.941470] ACPI: PCI: Interrupt link LNKG configured for IRQ 11
worker # [    0.942782] ACPI: PCI: Interrupt link LNKH configured for IRQ 11
worker # [    0.943398] ACPI: PCI: Interrupt link GSIA configured for IRQ 16
worker # [    0.944357] ACPI: PCI: Interrupt link GSIB configured for IRQ 17
worker # [    0.945355] ACPI: PCI: Interrupt link GSIC configured for IRQ 18
worker # [    0.946353] ACPI: PCI: Interrupt link GSID configured for IRQ 19
worker # [    0.947364] ACPI: PCI: Interrupt link GSIE configured for IRQ 20
worker # [    0.948352] ACPI: PCI: Interrupt link GSIF configured for IRQ 21
worker # [    0.949349] ACPI: PCI: Interrupt link GSIG configured for IRQ 22
worker # [    0.951371] ACPI: PCI: Interrupt link GSIH configured for IRQ 23
worker # [    0.954700] iommu: Default domain type: Translated
worker # [    0.955346] iommu: DMA domain TLB invalidation policy: lazy mode
worker # [    0.956680] ACPI: bus type USB registered
worker # [    0.957404] usbcore: registered new interface driver usbfs
worker # [    0.958365] usbcore: registered new interface driver hub
worker # [    0.960352] usbcore: registered new device driver usb
worker # [    0.962417] NetLabel: Initializing
worker # [    0.963336] NetLabel:  domain hash size = 128
worker # [    0.964336] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
worker # [    0.965376] NetLabel:  unlabeled traffic allowed by default
worker # [    0.966349] PCI: Using ACPI for IRQ routing
worker # [    1.103445] pci 0000:00:01.0: vgaarb: setting as boot VGA device
worker # [    1.104332] pci 0000:00:01.0: vgaarb: bridge control possible
worker # [    1.104332] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
worker # [    1.104337] vgaarb: loaded
worker # [    1.105569] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
worker # [    1.106344] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
worker # [    1.109438] clocksource: Switched to clocksource kvm-clock
worker # [    1.114807] VFS: Disk quotas dquot_6.6.0
worker # [    1.116199] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
worker # [    1.118292] pnp: PnP ACPI init
worker # [    1.119473] ACPI: IRQ 4 override to edge(!), high(!)
worker # [    1.121712] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved
worker # [    1.126430] pnp: PnP ACPI: found 6 devices
worker # [    1.138506] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
worker # [    1.143635] clocksource: Switched to clocksource acpi_pm
worker # [    1.145464] NET: Registered PF_INET protocol family
worker # [    1.147666] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
worker # [    1.174330] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
worker # [    1.177010] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
worker # [    1.178997] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
worker # [    1.181106] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
worker # [    1.183150] TCP: Hash tables configured (established 32768 bind 32768)
worker # [    1.185010] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)
worker # [    1.187396] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)
worker # [    1.189624] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)
worker # [    1.192073] NET: Registered PF_UNIX/PF_LOCAL protocol family
worker # [    1.193724] NET: Registered PF_XDP protocol family
worker # [    1.195135] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
worker # [    1.196918] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
worker # [    1.198547] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
worker # [    1.200647] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]
worker # [    1.202481] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]
worker # [    1.204457] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window]
worker # [    1.207403] ACPI: \_SB_.GSIA: Enabled at IRQ 16
worker # [    1.210291] ACPI: \_SB_.GSIB: Enabled at IRQ 17
worker # [    1.212895] ACPI: \_SB_.GSIC: Enabled at IRQ 18
worker # [    1.215150] ACPI: \_SB_.GSID: Enabled at IRQ 19
worker # [    1.217453] PCI: CLS 0 bytes, default 64
worker # [    1.218642] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
worker # [    1.220410] Trying to unpack rootfs image as initramfs...
worker # [    1.225415] software IO TLB: mapped [mem 0x000000007a36e000-0x000000007e36e000] (64MB)
worker # [    1.227629] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2caf45e6a57, max_idle_ns: 440795365367 ns
worker # [    1.272911] Initialise system trusted keyrings
worker # [    1.277242] workingset: timestamp_bits=40 max_order=20 bucket_order=0
worker # [    1.306065] Key type asymmetric registered
worker # [    1.307223] Asymmetric key parser 'x509' registered
worker # [    1.311033] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
worker # [    1.317115] io scheduler mq-deadline registered
worker # [    1.318324] io scheduler kyber registered
worker # [    1.323150] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
worker # [    1.327141] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
worker # [    1.333779] Linux agpgart interface v0.103
worker # [    1.334925] ACPI: bus type drm_connector registered
worker # [    1.338639] usbcore: registered new interface driver usbserial_generic
worker # [    1.344000] usbserial: USB Serial support registered for generic
worker # [    1.345516] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
worker # [    1.350148] drop_monitor: Initializing network drop monitor service
worker # [    1.351834] NET: Registered PF_INET6 protocol family
worker # [    1.357113] Segment Routing with IPv6
worker # [    1.358181] In-situ OAM (IOAM) with IPv6
worker # [    1.362261] IPI shorthand broadcast: enabled
worker # [    1.368306] sched_clock: Marking stable (1110028299, 257931715)->(2702452392, -1334492378)
worker # [    1.374105] registered taskstats version 1
worker # [    1.375418] Loading compiled-in X.509 certificates
worker # [    1.393261] Demotion targets for Node 0: null
worker # [    1.394732] Key type .fscrypt registered
worker # [    1.397973] Key type fscrypt-provisioning registered
worker # [    1.399392] ima: No TPM chip found, activating TPM-bypass!
worker # [    1.401981] ima: Allocated hash algorithm: sha1
worker # [    1.403217] ima: No architecture policies found
worker # [    1.408983] PM:   Magic number: 6:690:90
worker # [    1.413362] RAS: Correctable Errors collector initialized.
worker # [    1.425538] clk: Disabling unused clocks
worker # [    1.426644] PM: genpd: Disabling unused power domains
worker # [    1.677834] Freeing initrd memory: 29064K
worker # [    1.686417] Freeing unused decrypted memory: 2028K
worker # [    1.689614] Freeing unused kernel image (initmem) memory: 3644K
worker # [    1.691282] Write protecting the kernel read-only data: 32768k
worker # [    1.693831] Freeing unused kernel image (text/rodata gap) memory: 1216K
worker # [    1.695971] Freeing unused kernel image (rodata/data gap) memory: 756K
worker # [    1.736530] x86/mm: Checked W+X mappings: passed, no W+X pages found.
worker # [    1.738218] Run /init as init process
worker # [    1.748982] systemd[1]: Inserted module 'autofs4'
worker # [    1.767759] fuse: init (API version 7.45)
worker # [    1.774454] ACPI: \_SB_.GSIG: Enabled at IRQ 22
worker # [    1.779198] ACPI: \_SB_.GSIH: Enabled at IRQ 23
worker # [    1.783395] ACPI: \_SB_.GSIE: Enabled at IRQ 20
worker # [    1.786489] ACPI: \_SB_.GSIF: Enabled at IRQ 21
worker # [    1.824295] systemd[1]: Successfully made /usr/ read-only.
worker # [    2.161032] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
worker # [    2.169566] systemd[1]: Detected virtualization kvm.
worker # [    2.170981] systemd[1]: Detected architecture x86-64.
worker # [    2.172537] systemd[1]: Running in initrd.
worker # [    2.174315] systemd[1]: Initializing machine ID from random generator.
worker # [    2.178795] systemd[1]: Hostname set to <worker>.
hub # [    3.293582] Freeing initrd memory: 29060K
hub # [    3.298445] Freeing unused decrypted memory: 2028K
hub # [    3.301667] Freeing unused kernel image (initmem) memory: 3644K
hub # [    3.303441] Write protecting the kernel read-only data: 32768k
hub # [    3.305886] Freeing unused kernel image (text/rodata gap) memory: 1216K
hub # [    3.308396] Freeing unused kernel image (rodata/data gap) memory: 756K
hub # [    3.353456] x86/mm: Checked W+X mappings: passed, no W+X pages found.
worker # [    2.372818] systemd[1]: bpf-restrict-fs: LSM BPF program attached
hub # [    3.355376] Run /init as init process
hub # [    3.367760] systemd[1]: Inserted module 'autofs4'
hub # [    3.392130] fuse: init (API version 7.45)
hub # [    3.400091] ACPI: \_SB_.GSIG: Enabled at IRQ 22
worker # [    2.422137] systemd[1]: Queued start job for default target Initrd Default Target.
hub # [    3.404048] ACPI: \_SB_.GSIH: Enabled at IRQ 23
hub # [    3.409279] ACPI: \_SB_.GSIE: Enabled at IRQ 20
worker # [    2.428772] systemd[1]: Created slice Slice /system/modprobe.
worker # [    2.430994] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
worker # [    2.435100] systemd[1]: Expecting device /dev/disk/by-label/nixos...
hub # [    3.417250] ACPI: \_SB_.GSIF: Enabled at IRQ 21
worker # [    2.438531] systemd[1]: Reached target Path Units.
worker # [    2.440388] systemd[1]: Reached target Slice Units.
worker # [    2.442370] systemd[1]: Reached target Swaps.
worker # [    2.451039] systemd[1]: Reached target Timer Units.
worker # [    2.453174] systemd[1]: Listening on D-Bus System Message Bus Socket.
worker # [    2.457704] systemd[1]: Listening on Journal Socket (/dev/log).
worker # [    2.461614] systemd[1]: Listening on Journal Sockets.
worker # [    2.464620] systemd[1]: Listening on udev Control Socket.
worker # [    2.466372] systemd[1]: Listening on udev Kernel Socket.
worker # [    2.468226] systemd[1]: Reached target Socket Units.
worker # [    2.472649] systemd[1]: Starting Create List of Static Device Nodes...
hub # [    3.456823] systemd[1]: Successfully made /usr/ read-only.
worker # [    2.479585] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
worker # [    2.486169] systemd[1]: Starting Load Kernel Module configfs...
worker # [    2.502174] systemd[1]: Starting Journal Service...
worker # [    2.516725] systemd[1]: Starting Load Kernel Modules...
worker # [    2.527096] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
worker # [    2.530778] netfs: FS-Cache loaded
worker # [    2.540196] systemd[1]: Starting Coldplug All udev Devices...
worker # [    2.555221] 9pnet: Installing 9P2000 support
worker # [    2.566166] systemd[1]: Finished Create List of Static Device Nodes.
worker # [    2.717348] systemd[1]: modprobe@configfs.service: Deactivated successfully.
worker # [    2.726242] systemd-journald[67]: Collecting audit messages is disabled.
worker # [    2.739771] systemd[1]: Finished Load Kernel Module configfs.
worker # [    2.750822] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
worker # [    2.761312] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
worker # [    2.770626] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
worker # [    2.783698] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config
worker # [    2.790102] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
hub # [    3.794257] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
hub # [    3.802433] systemd[1]: Detected virtualization kvm.
hub # [    3.803837] systemd[1]: Detected architecture x86-64.
worker # [    2.820771] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
hub # [    3.805391] systemd[1]: Running in initrd.
hub # [    3.806980] systemd[1]: Initializing machine ID from random generator.
hub # [    3.809382] systemd[1]: Hostname set to <hub>.
worker # [    2.858077] systemd[1]: Finished Load Kernel Modules.
worker # [    2.884059] systemd[1]: Starting Apply Kernel Variables...
worker # [    2.919109] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
worker # [    2.949075] systemd[1]: Starting Create Static Device Nodes in /dev...
worker # [    2.969046] systemd[1]: Finished Apply Kernel Variables.
worker # [    2.991174] systemd[1]: Finished Create Static Device Nodes in /dev.
worker # [    2.999825] systemd[1]: Reached target Preparation for Local File Systems.
hub # [    4.000422] systemd[1]: bpf-restrict-fs: LSM BPF program attached
worker # [    3.019210] systemd[1]: Reached target Local File Systems.
worker # [    3.056010] systemd[1]: Starting Rule-based Manager for Device Events and Files...
hub # [    4.053106] systemd[1]: Queued start job for default target Initrd Default Target.
hub # [    4.059692] systemd[1]: Created slice Slice /system/modprobe.
hub # [    4.061609] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
hub # [    4.063888] systemd[1]: Expecting device /dev/disk/by-label/nixos...
hub # [    4.065710] systemd[1]: Reached target Path Units.
hub # [    4.067061] systemd[1]: Reached target Slice Units.
hub # [    4.068855] systemd[1]: Reached target Swaps.
hub # [    4.070495] systemd[1]: Reached target Timer Units.
hub # [    4.072145] systemd[1]: Listening on D-Bus System Message Bus Socket.
hub # [    4.074227] systemd[1]: Listening on Journal Socket (/dev/log).
hub # [    4.076491] systemd[1]: Listening on Journal Sockets.
hub # [    4.078597] systemd[1]: Listening on udev Control Socket.
hub # [    4.080416] systemd[1]: Listening on udev Kernel Socket.
hub # [    4.082170] systemd[1]: Reached target Socket Units.
hub # [    4.084665] systemd[1]: Starting Create List of Static Device Nodes...
hub # [    4.091398] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
worker # [    2.845896] systemd-modules-load[68]: Inserted module 'dm_mod'
hub # [    4.098992] systemd[1]: Starting Load Kernel Module configfs...
worker # [    2.856369] systemd-modules-load[68]: Inserted module 'virtio_balloon'
hub # [    4.114542] systemd[1]: Starting Journal Service...
worker # [    2.880578] systemd-modules-load[68]: Inserted module 'virtio_gpu'[    3.148727] systemd[1]: Started Journal Service.
hub # [    4.132613] systemd[1]: Starting Load Kernel Modules...
hub # [    4.140995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
worker # 
hub # [    4.150090] netfs: FS-Cache loaded
hub # [    4.154403] systemd[1]: Starting Coldplug All udev Devices...
hub # [    4.181190] 9pnet: Installing 9P2000 support
hub # [    4.184791] systemd[1]: Finished Create List of Static Device Nodes.
hub # [    4.189100] systemd-journald[67]: Collecting audit messages is disabled.
hub # [    4.200236] systemd[1]: modprobe@configfs.service: Deactivated successfully.
hub # [    4.211996] systemd[1]: Finished Load Kernel Module configfs.
hub # [    4.218929] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
hub # [    4.228147] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
hub # [    4.231434] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
hub # [    4.238163] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config
hub # [    4.243540] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
worker # [    3.006130] systemd[1]: Starting Create System Files and Directories...
hub # [    4.255547] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
hub # [    4.283404] systemd[1]: Finished Load Kernel Modules.
worker # [    3.060700] systemd[1]: Finished Create System Files and Directories.
hub # [    4.297906] systemd[1]: Starting Apply Kernel Variables...
worker # [    3.068507] systemd-udevd[75]: Using default interface naming scheme 'v261'.
worker # [    3.081835] systemd[1]: Finished Coldplug All udev Devices.
hub # [    4.321423] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
worker # [    3.096561] systemd[1]: Started Rule-based Manager for Device Events and Files.
hub # [    4.335897] systemd[1]: Starting Create Static Device Nodes in /dev...
worker # [    3.099827] systemd[1]: Reached target System Initialization.
worker # [    3.101144] systemd[1]: Reached target Basic System.
hub # [    4.357464] systemd[1]: Finished Apply Kernel Variables.
hub # [    4.384400] systemd[1]: Finished Create Static Device Nodes in /dev.
hub # [    4.393772] systemd[1]: Reached target Preparation for Local File Systems.
hub # [    4.400465] systemd[1]: Reached target Local File Systems.
hub # [    4.408858] systemd[1]: Starting Rule-based Manager for Device Events and Files...
hub # [    4.172390] systemd-modules-load[68]: Inserted module 'dm_mod'
hub # [    4.176612] systemd-modules-load[68]: Inserted module 'virtio_balloon'
hub # [    4.178367] systemd-modules-load[68]: Inserted module 'virtio_gpu'
hub # [    4.435628] systemd[1]: Started Journal Service.
hub # [    4.209117] systemd[1]: Starting Create System Files and Directories...
hub # [    4.241608] systemd[1]: Finished Create System Files and Directories.
hub # [    4.244492] systemd-udevd[75]: Using default interface naming scheme 'v261'.
hub # [    4.256867] systemd[1]: Finished Coldplug All udev Devices.
hub # [    4.269604] systemd[1]: Started Rule-based Manager for Device Events and Files.
hub # [    4.272099] systemd[1]: Reached target System Initialization.
hub # [    4.273307] systemd[1]: Reached target Basic System.
worker # [    3.673682] virtio_blk virtio5: 1/0/0 default/read/poll queues
worker # [    3.732517] virtio_blk virtio5: [vda] 16777216 512-byte logical blocks (8.59 GB/8.00 GiB)
worker # [    3.738099] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
worker # [    3.744955] ehci-pci 0000:00:1d.7: EHCI Host Controller
worker # [    3.746281] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1
worker # [    3.749289] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000
worker # [    3.755974] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00
worker # [    3.759380] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18
worker # [    3.761351] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
worker # [    3.767191] usb usb1: Product: EHCI Host Controller
worker # [    3.769627] usb usb1: Manufacturer: Linux 6.18.46 ehci_hcd
worker # [    3.771949] usb usb1: SerialNumber: 0000:00:1d.7
worker # [    3.775139] hub 1-0:1.0: USB hub found
worker # [    3.776992] hub 1-0:1.0: 6 ports detected
worker # [    3.788870] serio: i8042 KBD port at 0x60,0x64 irq 1
worker # [    3.792134] uhci_hcd 0000:00:1d.0: UHCI Host Controller
worker # [    3.793506] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
worker # [    3.808683] serio: i8042 AUX port at 0x60,0x64 irq 12
worker # [    3.821153] uhci_hcd 0000:00:1d.0: detected 2 ports
worker # [    3.830675] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200
hub # [    4.811663] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
worker # [    3.838061] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
hub # [    4.819906] virtio_blk virtio5: 1/0/0 default/read/poll queues
worker # [    3.839747] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
worker # [    3.598259] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.
worker # [    3.863093] SCSI subsystem initialized
hub # [    4.850265] serio: i8042 KBD port at 0x60,0x64 irq 1
worker # [    3.613761] (udev-worker)[87]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
worker # [    3.618102] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.
hub # [    4.859207] virtio_blk virtio5: [vda] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)
worker # [    3.882033] usb usb2: Product: UHCI Host Controller
worker # [    3.883193] usb usb2: Manufacturer: Linux 6.18.46 uhci_hcd
hub # [    4.870585] ehci-pci 0000:00:1d.7: EHCI Host Controller
hub # [    4.871720] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1
hub # [    4.874628] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000
worker # [    3.637699] systemd[1]: Starting Virtual Console Setup...
hub # [    4.879317] serio: i8042 AUX port at 0x60,0x64 irq 12
hub # [    4.882763] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00
hub # [    4.884073] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18
hub # [    4.888100] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
worker # [    3.907099] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
hub # [    4.891319] usb usb1: Product: EHCI Host Controller
hub # [    4.893314] usb usb1: Manufacturer: Linux 6.18.46 ehci_hcd
hub # [    4.896068] usb usb1: SerialNumber: 0000:00:1d.7
worker # [    3.917984] usb usb2: SerialNumber: 0000:00:1d.0
hub # [    4.898484] hub 1-0:1.0: USB hub found
hub # [    4.900337] hub 1-0:1.0: 6 ports detected
hub # [    4.905391] uhci_hcd 0000:00:1d.0: UHCI Host Controller
hub # [    4.906531] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
worker # [    3.941295] hub 2-0:1.0: USB hub found
hub # [    4.924639] uhci_hcd 0000:00:1d.0: detected 2 ports
worker # [    3.691193] systemd-vconsole-setup[109]: Configuration of first virtual console was skipped, ignoring remaining ones.
worker # [    3.695231] systemd[1]: Finished Virtual Console Setup.
hub # [    4.934466] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200
worker # [    3.961488] hub 2-0:1.0: 2 ports detected
hub # [    4.946340] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
hub # [    4.948042] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
worker # [    3.969820] uhci_hcd 0000:00:1d.1: UHCI Host Controller
worker # [    3.978124] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
hub # [    4.963649] SCSI subsystem initialized
worker # [    3.728126] systemd[1]: Found device /dev/disk/by-label/nixos.
hub # [    4.715538] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.
worker # [    3.731091] systemd[1]: Reached target Initrd Root Device.
worker # [    3.733092] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
worker # [    3.992758] uhci_hcd 0000:00:1d.1: detected 2 ports
worker # [    3.994237] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220
hub # [    4.727426] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
hub # [    4.730617] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.
worker # [    4.001149] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
hub # [    4.737927] systemd[1]: Starting Virtual Console Setup...
worker # [    4.009955] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
worker # [    4.014959] usb usb3: Product: UHCI Host Controller
worker # [    4.020014] usb usb3: Manufacturer: Linux 6.18.46 uhci_hcd
worker # [    4.021948] usb 1-1: new high-speed USB device number 2 using ehci-pci
worker # [    4.023670] usb usb3: SerialNumber: 0000:00:1d.1
hub # [    5.005332] usb usb2: Product: UHCI Host Controller
worker # [    4.026601] hub 3-0:1.0: USB hub found
hub # [    5.008830] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
worker # [    4.029004] hub 3-0:1.0: 2 ports detected
worker # [    4.036967] uhci_hcd 0000:00:1d.2: UHCI Host Controller
hub # [    5.024589] usb usb2: Manufacturer: Linux 6.18.46 uhci_hcd
worker # [    4.045094] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
hub # [    4.777571] systemd-vconsole-setup[106]: Configuration of first virtual console was skipped, ignoring remaining ones.
worker # [    4.051768] uhci_hcd 0000:00:1d.2: detected 2 ports
hub # [    4.783748] systemd[1]: Finished Virtual Console Setup.
worker # [    4.056238] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240
worker # [    3.800404] systemd-fsck[116]: nixos: clean, 12/524288 files, 58513/2097152 blocks
hub # [    5.040567] usb usb2: SerialNumber: 0000:00:1d.0
worker # [    4.060573] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
worker # [    4.063135] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode
worker # [    4.064826] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)
hub # [    5.046991] hub 2-0:1.0: USB hub found
worker # [    4.066833] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
worker # [    4.068641] usb usb4: Product: UHCI Host Controller
hub # [    5.051316] hub 2-0:1.0: 2 ports detected
hub # [    5.058753] uhci_hcd 0000:00:1d.1: UHCI Host Controller
hub # [    4.811105] systemd[1]: Found device /dev/disk/by-label/nixos.
hub # [    4.812412] systemd[1]: Reached target Initrd Root Device.
hub # [    4.817098] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
worker # [    4.070121] ahci 0000:00:1f.2: flags: 64bit ncq only
hub # [    5.072321] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
hub # [    5.076380] uhci_hcd 0000:00:1d.1: detected 2 ports
hub # [    5.084476] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220
hub # [    5.088368] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
hub # [    5.089969] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
hub # [    5.095419] usb usb3: Product: UHCI Host Controller
hub # [    5.098364] usb usb3: Manufacturer: Linux 6.18.46 uhci_hcd
hub # [    5.100373] usb usb3: SerialNumber: 0000:00:1d.1
hub # [    5.103410] hub 3-0:1.0: USB hub found
worker # [    4.119157] usb usb4: Manufacturer: Linux 6.18.46 uhci_hcd
hub # [    5.111604] hub 3-0:1.0: 2 ports detected
hub # [    4.862753] systemd-fsck[113]: nixos: clean, 12/262144 files, 37198/1048576 blocks
hub # [    5.119217] uhci_hcd 0000:00:1d.2: UHCI Host Controller
hub # [    5.123361] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
hub # [    5.126646] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode
hub # [    5.128379] uhci_hcd 0000:00:1d.2: detected 2 ports
hub # [    5.130143] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240
hub # [    5.131699] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)
hub # [    5.133739] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
hub # [    5.135462] ahci 0000:00:1f.2: flags: 64bit ncq only
hub # [    5.136960] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
hub # [    5.142312] usb 1-1: new high-speed USB device number 2 using ehci-pci
worker # [    3.885656] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
hub # [    5.145943] usb usb4: Product: UHCI Host Controller
hub # [    5.147326] scsi host0: ahci
worker # [    4.167979] usb usb4: SerialNumber: 0000:00:1d.2
hub # [    5.152219] usb usb4: Manufacturer: Linux 6.18.46 uhci_hcd
hub # [    4.902066] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
hub # [    5.157429] scsi host1: ahci
hub # [    5.159230] usb usb4: SerialNumber: 0000:00:1d.2
hub # [    5.161651] scsi host2: ahci
hub # [    5.162611] hub 4-0:1.0: USB hub found
worker # [    4.176984] hub 4-0:1.0: USB hub found
hub # [    5.165240] scsi host3: ahci
hub # [    5.167003] hub 4-0:1.0: 2 ports detected
worker # [    4.187158] scsi host0: ahci
hub # [    5.169177] scsi host4: ahci
hub # [    5.172422] scsi host5: ahci
worker # [    4.189613] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
hub # [    5.174380] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1
hub # [    5.175943] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1
worker # [    4.194058] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
hub # [    4.928809] systemd[1]: Mounting /sysroot...
worker # [    4.200484] usb 1-1: Product: QEMU USB Tablet
worker # [    4.207280] hub 4-0:1.0: 2 ports detected
worker # [    4.210584] usb 1-1: Manufacturer: QEMU
worker # [    4.216950] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1
worker # [    4.221378] scsi host1: ahci
hub # [    5.204369] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1
worker # [    4.231289] scsi host2: ahci
worker # [    4.235299] scsi host3: ahci
worker # [    4.240039] scsi host4: ahci
hub # [    5.221475] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1
worker # [    4.246313] scsi host5: ahci
hub # [    5.237493] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1
hub # [    5.251511] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1
worker # [    4.250659] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1
worker # [    4.290994] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1
hub # [    5.289324] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
hub # [    5.291220] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
hub # [    5.295355] usb 1-1: Product: QEMU USB Tablet
hub # [    5.297583] usb 1-1: Manufacturer: QEMU
hub # [    5.301313] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1
hub # [    5.333973] hid: raw HID events driver (C) Jiri Kosina
worker # [    4.427129] hid: raw HID events driver (C) Jiri Kosina
worker # [    4.430085] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1
worker # [    4.434955] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1
worker # [    4.439879] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1
worker # [    4.444422] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1
worker # [    4.453426] usbcore: registered new interface driver usbhid
worker # [    4.455829] usbhid: USB HID core driver
worker # [    4.301838] systemd[1]: Mounting /sysroot...
hub # [    5.562210] ata1: SATA link down (SStatus 0 SControl 300)
hub # [    5.569464] ata5: SATA link down (SStatus 0 SControl 300)
hub # [    5.572989] ata2: SATA link down (SStatus 0 SControl 300)
hub # [    5.577511] ata6: SATA link down (SStatus 0 SControl 300)
hub # [    5.581351] ata4: SATA link down (SStatus 0 SControl 300)
hub # [    5.583834] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
hub # [    5.592133] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
hub # [    5.597721] ata3.00: applying bridge limits
hub # [    5.603775] ata3.00: configured for UDMA/100
hub # [    5.605911] scsi 2:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
hub # [    5.673635] usbcore: registered new interface driver usbhid
hub # [    5.678155] usbhid: USB HID core driver
hub # [    5.705632] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2
hub # [    5.712374] 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 # [    5.720553] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
hub # [    5.742458] cdrom: Uniform CD-ROM driver Revision: 3.20
worker # [    4.766442] ata4: SATA link down (SStatus 0 SControl 300)
worker # [    4.768013] ata2: SATA link down (SStatus 0 SControl 300)
worker # [    4.771867] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
worker # [    4.773471] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
worker # [    4.778356] ata3.00: applying bridge limits
worker # [    4.782366] ata3.00: configured for UDMA/100
worker # [    4.785123] ata1: SATA link down (SStatus 0 SControl 300)
worker # [    4.786713] ata5: SATA link down (SStatus 0 SControl 300)
worker # [    4.789960] ata6: SATA link down (SStatus 0 SControl 300)
worker # [    4.794361] scsi 2:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
worker # [    4.899338] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2
hub # [    5.879236] EXT4-fs (vda): mounted filesystem 053c8b64-2333-4ee2-adbd-17c05cbfecf6 r/w with ordered data mode. Quota mode: none.
hub # [    5.633289] systemd[1]: Mounted /sysroot.
hub # [    5.635388] systemd[1]: Reached target Initrd Root File System.
hub # [    5.639107] systemd[1]: Mounting /sysroot/nix/.ro-store...
hub # [    5.644127] systemd[1]: Mounting /sysroot/nix/.rw-store...
worker # [    4.916966] 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 # [    5.649288] systemd[1]: Mounting /sysroot/run...
hub # [    5.656217] systemd[1]: Mounting /sysroot/tmp/shared...
hub # [    5.663339] systemd[1]: Mounting /sysroot/tmp/xchg...
hub # [    5.672317] systemd[1]: Starting Mountpoints Configured in the Real Root...
worker # [    4.972137] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
worker # [    4.986400] cdrom: Uniform CD-ROM driver Revision: 3.20
hub # [    5.968870] 9p: Installing v9fs 9p2000 file system support
hub # [    5.719861] systemd[1]: Mounted /sysroot/nix/.rw-store.
worker # [    4.988433] EXT4-fs (vda): mounted filesystem 069a48ed-e3fd-4109-b8d3-6a0d9ac6a677 r/w with ordered data mode. Quota mode: none.
hub # [    5.736072] systemd-sysroot-fstab-check[154]: /sysroot should be mounted in the initrd, will request daemon-reload.
hub # [    5.743118] systemd[1]: Mounted /sysroot/run.
hub # [    5.745752] systemd[1]: Reload requested from client PID 154 ('systemd-sysroot') (unit initrd-parse-etc.service)...
hub # [    5.753250] systemd[1]: Reloading...
worker # [    4.795384] systemd[1]: Mounted /sysroot.
worker # [    4.801598] systemd[1]: Reached target Initrd Root File System.
worker # [    4.811372] systemd[1]: Starting Mountpoints Configured in the Real Root...
worker # [    4.836492] systemd-sysroot-fstab-check[148]: /sysroot should be mounted in the initrd, will request daemon-reload.
worker # [    4.849107] systemd[1]: Reload requested from client PID 148 ('systemd-sysroot') (unit initrd-parse-etc.service)...
worker # [    4.852879] systemd[1]: Reloading...
hub # [    5.942604] systemd[1]: Reloading finished in 176 ms.
hub # [    5.967131] systemd-sysroot-fstab-check[154]: Requesting initrd-fs.target/start/replace...
hub # [    5.978112] systemd[1]: Mounted /sysroot/nix/.ro-store.
hub # [    5.985835] systemd[1]: Mounted /sysroot/tmp/shared.
hub # [    5.995140] systemd[1]: Mounted /sysroot/tmp/xchg.
hub # [    6.000130] systemd-sysroot-fstab-check[154]: Requesting swap.target/start/replace...
hub # [    6.003940] systemd[1]: Starting rw-sysroot-nix-store.service...
hub # [    6.006412] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
hub # [    6.009299] systemd[1]: Finished Mountpoints Configured in the Real Root.
hub # [    6.011228] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
worker # [    5.028335] systemd[1]: Reloading finished in 180 ms.
hub # [    6.026242] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
worker # [    5.039829] systemd-sysroot-fstab-check[148]: Requesting initrd-fs.target/start/replace...
hub # [    6.028884] systemd[1]: Finished rw-sysroot-nix-store.service.
hub # [    6.032682] systemd[1]: Mounting /sysroot/nix/store...
worker # [    5.051085] systemd-sysroot-fstab-check[148]: Requesting swap.target/start/replace...
worker # [    5.059288] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
worker # [    5.069711] systemd[1]: Finished Mountpoints Configured in the Real Root.
worker # [    5.071527] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
hub # [    6.071720] systemd[1]: Mounted /sysroot/nix/store.
hub # [    6.073918] systemd[1]: Reached target Initrd File Systems.
hub # [    6.076839] systemd[1]: Starting Find NixOS closure...
worker # [    5.090808] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
hub # [    6.082302] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
hub # [    6.136600] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
hub # [    6.142174] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
hub # [    6.162139] systemd[1]: Finished Find NixOS closure.
hub # [    6.168949] systemd[1]: Reached target Initrd Default Target.
hub # [    6.189168] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
hub # [    6.222356] systemd[1]: initrd-cleanup.service: Deactivated successfully.
hub # [    6.226192] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
hub # [    6.249349] systemd[1]: Stopped target Initrd Default Target.
hub # [    6.250888] systemd[1]: Stopped target Basic System.
hub # [    6.259975] systemd[1]: Stopped target Initrd Root Device.
hub # [    6.295340] systemd[1]: Stopped target Path Units.
worker # [    5.306169] systemd[1]: Mounting /sysroot/nix/.ro-store...
hub # [    6.307805] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
hub # [    6.312775] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
hub # [    6.316228] systemd[1]: Stopped target Slice Units.
hub # [    6.318048] systemd[1]: Stopped target Socket Units.
hub # [    6.322204] systemd[1]: Stopped target System Initialization.
hub # [    6.325611] systemd[1]: Stopped target Swaps.
hub # [    6.328726] systemd[1]: Stopped target Timer Units.
hub # [    6.330195] systemd[1]: dbus.socket: Deactivated successfully.
hub # [    6.332723] systemd[1]: Closed D-Bus System Message Bus Socket.
hub # [    6.334481] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
worker # [    5.350273] systemd[1]: Mounting /sysroot/nix/.rw-store...
hub # [    6.336774] systemd[1]: Stopped Find NixOS closure.
hub # [    6.342718] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
hub # [    6.346916] systemd[1]: Starting rw-sysroot-nix-store.service...
hub # [    6.349237] systemd[1]: systemd-sysctl.service: Deactivated successfully.
hub # [    6.352411] systemd[1]: Stopped Apply Kernel Variables.
hub # [    6.353900] systemd[1]: systemd-modules-load.service: Deactivated successfully.
worker # [    5.370168] systemd[1]: Mounting /sysroot/run...
hub # [    6.356788] systemd[1]: Stopped Load Kernel Modules.
hub # [    6.358858] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
hub # [    6.362380] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
hub # [    6.366839] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
hub # [    6.370194] systemd[1]: Stopped Create System Files and Directories.
hub # [    6.373113] systemd[1]: Stopped target Local File Systems.
hub # [    6.378784] systemd[1]: Stopped target Preparation for Local File Systems.
worker # [    5.398143] systemd[1]: Mounting /sysroot/tmp/shared...
hub # [    6.386744] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
hub # [    6.396285] systemd[1]: Stopped Coldplug All udev Devices.
worker # [    5.431689] systemd[1]: Mounting /sysroot/tmp/xchg...
hub # [    6.420419] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
hub # [    6.430096] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
hub # [    6.433902] systemd[1]: Stopped Virtual Console Setup.
worker # [    5.466121] systemd[1]: Mounted /sysroot/nix/.rw-store.
hub # [    6.459990] systemd[1]: systemd-udevd.service: Deactivated successfully.
hub # [    6.462295] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
hub # [    6.464859] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
worker # [    5.729863] 9p: Installing v9fs 9p2000 file system support
hub # [    6.467777] systemd[1]: Finished rw-sysroot-nix-store.service.
hub # [    6.471421] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
hub # [    6.473525] systemd[1]: Closed udev Control Socket.
hub # [    6.476275] systemd[1]: Starting Cleanup udev Database...
hub # [    6.479172] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
hub # [    6.482234] systemd[1]: Stopped Create Static Device Nodes in /dev.
hub # [    6.483882] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
hub # [    6.485820] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
hub # [    6.488780] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
hub # [    6.490259] systemd[1]: Stopped Create List of Static Device Nodes.
hub # [    6.507142] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
hub # [    6.510467] systemd[1]: Finished Cleanup udev Database.
worker # [    5.527909] systemd[1]: Mounted /sysroot/nix/.ro-store.
hub # [    6.515450] systemd[1]: Reached target Switch Root.
hub # [    6.518349] systemd[1]: Starting NixOS Activation...
worker # [    5.554414] systemd[1]: Starting rw-sysroot-nix-store.service...
worker # [    5.561929] systemd[1]: Mounted /sysroot/run.
worker # [    5.571232] systemd[1]: Mounted /sysroot/tmp/shared.
worker # [    5.581157] systemd[1]: Mounted /sysroot/tmp/xchg.
worker # [    5.588341] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
worker # [    5.595730] systemd[1]: Finished rw-sysroot-nix-store.service.
hub # [    6.941593] initrd-nixos-activation-start[201]: booting system configuration /nix/store/0zr0mac8vpixj4gbcazcpnpd335lfgdj-nixos-system-hub-test
hub # [    7.080224] initrd-nixos-activation-start[201]: running activation script...
worker # [    6.305312] systemd[1]: Mounting /sysroot/nix/store...
worker # [    6.459200] systemd[1]: Mounted /sysroot/nix/store.
worker # [    6.478390] systemd[1]: Reached target Initrd File Systems.
worker # [    6.490532] systemd[1]: Starting Find NixOS closure...
worker # [    6.533478] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
worker # [    6.670284] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
worker # [    6.675825] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
worker # [    6.694709] systemd[1]: Finished Find NixOS closure.
worker # [    6.696813] systemd[1]: Reached target Initrd Default Target.
worker # [    6.700568] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
worker # [    6.724863] systemd[1]: Stopped target Initrd Default Target.
worker # [    6.727286] systemd[1]: Stopped target Basic System.
worker # [    6.734088] systemd[1]: Stopped target Initrd Root Device.
worker # [    6.735641] systemd[1]: Stopped target Path Units.
worker # [    6.737824] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
worker # [    6.745832] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
worker # [    6.761406] systemd[1]: Stopped target Slice Units.
worker # [    6.764317] systemd[1]: Stopped target Socket Units.
worker # [    6.770564] systemd[1]: Stopped target System Initialization.
worker # [    6.772467] systemd[1]: Stopped target Swaps.
worker # [    6.775232] systemd[1]: Stopped target Timer Units.
worker # [    6.778743] systemd[1]: dbus.socket: Deactivated successfully.
worker # [    6.781341] systemd[1]: Closed D-Bus System Message Bus Socket.
worker # [    6.784407] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
worker # [    6.800624] systemd[1]: Stopped Find NixOS closure.
worker # [    6.808334] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
worker # [    6.836640] systemd[1]: Starting rw-sysroot-nix-store.service...
worker # [    6.844959] systemd[1]: systemd-sysctl.service: Deactivated successfully.
worker # [    6.859597] systemd[1]: Stopped Apply Kernel Variables.
worker # [    7.057197] systemd[1]: systemd-modules-load.service: Deactivated successfully.
hub # [    8.063688] initrd-nixos-activation-start[224]: setting up /etc...
worker # [    7.115637] systemd[1]: Stopped Load Kernel Modules.
worker # [    7.123956] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
worker # [    7.134876] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
worker # [    7.147759] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
worker # [    7.158057] systemd[1]: Stopped Create System Files and Directories.
worker # [    7.163948] systemd[1]: Stopped target Local File Systems.
worker # [    7.169825] systemd[1]: Stopped target Preparation for Local File Systems.
worker # [    7.181913] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
worker # [    7.201140] systemd[1]: Stopped Coldplug All udev Devices.
worker # [    7.207846] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
worker # [    7.209931] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
worker # [    7.214581] systemd[1]: Stopped Virtual Console Setup.
worker # [    7.228623] systemd[1]: systemd-udevd.service: Deactivated successfully.
worker # [    7.231921] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
worker # [    7.235747] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
worker # [    7.239305] systemd[1]: Finished rw-sysroot-nix-store.service.
worker # [    7.244415] systemd[1]: initrd-cleanup.service: Deactivated successfully.
worker # [    7.249242] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
worker # [    7.253850] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
worker # [    7.255930] systemd[1]: Closed udev Control Socket.
worker # [    7.259405] systemd[1]: Starting Cleanup udev Database...
worker # [    7.261507] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
worker # [    7.264752] systemd[1]: Stopped Create Static Device Nodes in /dev.
worker # [    7.270305] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
worker # [    7.274266] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
worker # [    7.276256] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
worker # [    7.281985] systemd[1]: Stopped Create List of Static Device Nodes.
worker # [    7.315649] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
worker # [    7.323707] systemd[1]: Finished Cleanup udev Database.
worker # [    7.331274] systemd[1]: Reached target Switch Root.
worker # [    7.334175] systemd[1]: Starting NixOS Activation...
hub # [    9.475488] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
hub # [    9.478235] systemd[1]: Finished NixOS Activation.
hub # [    9.481277] systemd[1]: Starting Switch Root...
hub # [    9.500425] systemd[1]: Switching root.
hub # [    9.884714] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).
worker # [    9.130440] initrd-nixos-activation-start[202]: booting system configuration /nix/store/j51r5d2d407894f465jsqbira27yqshb-nixos-system-worker-test
hub # [   10.832599] NET: Registered PF_VSOCK protocol family
worker # [    9.806453] initrd-nixos-activation-start[202]: running activation script...
hub # [   11.529635] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
hub # [   11.538928] systemd[1]: Detected virtualization kvm.
hub # [   11.541184] systemd[1]: Detected architecture x86-64.
hub # [   11.545945] systemd[1]: Detected first boot.
hub # [   11.562613] systemd[1]: Initializing machine ID from random generator.
hub # [   12.472519] systemd[1]: bpf-restrict-fs: LSM BPF program attached
hub # [   13.511983] systemd[1]: Applying preset policy.
hub # [   14.816302] systemd[1]: Populated /etc with preset unit settings.
worker # [   17.429590] initrd-nixos-activation-start[225]: setting up /etc...
worker # [   19.474731] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
worker # [   19.481273] systemd[1]: Finished NixOS Activation.
worker # [   19.490060] systemd[1]: Starting Switch Root...
worker # [   19.521470] systemd[1]: Switching root.
worker # [   19.933481] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).
hub # [   23.381466] systemd[1]: initrd-switch-root.service: Deactivated successfully.
hub # [   23.386302] systemd[1]: Stopped initrd-switch-root.service.
hub # [   23.395741] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
hub # [   23.400441] systemd[1]: Created slice Slice /system/getty.
hub # [   23.403648] systemd[1]: Created slice User and Session Slice.
hub # [   23.406796] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
hub # [   23.409942] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
hub # [   23.412675] systemd[1]: Expecting device /dev/hvc0...
hub # [   23.414252] systemd[1]: Expecting device /dev/ttyS0...
hub # [   23.417405] systemd[1]: Reached target Local Encrypted Volumes.
hub # [   23.419840] systemd[1]: Stopped target initrd-fs.target.
hub # [   23.421190] systemd[1]: Stopped target initrd-root-fs.target.
hub # [   23.424139] systemd[1]: Stopped target initrd-switch-root.target.
hub # [   23.426349] systemd[1]: Reached target Virtual Machines and Containers.
hub # [   23.429438] systemd[1]: Reached target Path Units.
hub # [   23.431254] systemd[1]: Reached target Remote File Systems.
hub # [   23.435883] systemd[1]: Reached target Slice Units.
hub # [   23.437255] systemd[1]: Reached target Swaps.
hub # [   23.460958] systemd[1]: Listening on Query the User Interactively for a Password.
hub # [   23.482626] systemd[1]: Listening on Process Core Dump Socket.
hub # [   23.496019] systemd[1]: Listening on Credential Encryption/Decryption.
hub # [   23.507641] systemd[1]: Listening on Factory Reset Management.
hub # [   23.510244] systemd[1]: Listening on Hostname Service Socket.
hub # [   23.532412] systemd[1]: Starting Journal Log Access Socket...
hub # [   23.536600] systemd[1]: Listening on Journal Audit Socket.
hub # [   23.555338] systemd[1]: Listening on Console Output Muting Service Socket.
hub # [   23.556982] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
hub # [   23.567202] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
hub # [   23.569541] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
hub # [   23.632968] systemd[1]: Listening on Disk Repartitioning Service Socket.
hub # [   23.634639] systemd[1]: Listening on udev Control Socket.
hub # [   23.638004] systemd[1]: Listening on udev Varlink Socket.
hub # [   23.654620] systemd[1]: Mounting Huge Pages File System...
hub # [   23.662018] systemd[1]: Mounting POSIX Message Queue File System...
hub # [   23.673305] systemd[1]: Mounting Kernel Debug File System...
hub # [   23.704570] systemd[1]: Mounting Kernel Trace File System...
hub # [   23.728263] systemd[1]: Starting Create List of Static Device Nodes...
hub # [   23.731604] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
hub # [   23.763026] systemd[1]: Starting Load Kernel Module configfs...
hub # [   23.769957] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
hub # [   23.777043] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
hub # [   23.788019] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
hub # [   23.977612] systemd[1]: Mounting FUSE Control File System...
hub # [   24.000457] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
hub # [   24.205607] systemd[1]: Starting Journal Service...
hub # [   24.219629] systemd[1]: Starting Load Kernel Modules...
hub # [   24.239952] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
hub # [   24.262638] systemd[1]: Starting Remount Root and Kernel File Systems...
hub # [   24.282887] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
hub # [   24.325153] systemd[1]: Starting Coldplug All udev Devices...
hub # [   24.328888] systemd[1]: Listening on Journal Log Access Socket.
hub # [   24.882192] systemd[1]: Finished Create List of Static Device Nodes.
hub # [   24.922735] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
hub # [   24.962201] EXT4-fs (vda): re-mounted 053c8b64-2333-4ee2-adbd-17c05cbfecf6.
hub # [   24.981938] systemd[1]: Finished Remount Root and Kernel File Systems.
hub # [   24.985612] systemd[1]: Listening on Disk Image Download Service Socket.
hub # [   24.989269] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
hub # [   25.051278] systemd[1]: Starting Load/Save OS Random Seed...
hub # [   25.076255] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
hub # [   25.278606] systemd-journald[294]: Collecting audit messages is enabled.
hub # [   25.353937] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
hub # [   25.432868] loop: module loaded
hub # [   25.438508] systemd[1]: Mounted Huge Pages File System.
hub # [   25.441908] systemd[1]: Mounted POSIX Message Queue File System.
hub # [   25.448181] systemd[1]: Mounted Kernel Debug File System.
hub # [   25.461805] systemd[1]: Mounted Kernel Trace File System.
hub # [   25.478580] systemd[1]: modprobe@configfs.service: Deactivated successfully.
hub # [   25.497168] systemd[1]: Finished Load Kernel Module configfs.
hub # [   25.501483] systemd[1]: Mounted FUSE Control File System.
hub # [   25.509007] systemd[1]: Started Journal Service.
hub # [   25.259883] systemd[1]: Queued start job for default target Multi-User System.
hub # [   25.262285] systemd[1]: systemd-journald.service: Deactivated successfully.
hub # [   25.264968] systemd-oomd[296]: No swap; memory pressure usage will be degraded
hub # [   25.272530] systemd-modules-load[295]: Inserted module 'loop'
hub # [   25.275383] systemd[1]: Finished Load Kernel Modules.
hub # [   25.324649] systemd[1]: Mounting Kernel Configuration File System...
hub # [   25.355277] systemd[1]: Starting Firewall...
hub # [   25.384178] systemd[1]: Starting Flush Journal to Persistent Storage...
hub # [   25.402663] systemd[1]: Starting Apply Kernel Variables...
hub # [   25.447992] systemd[1]: Finished Coldplug All udev Devices.
hub # [   25.485092] systemd[1]: Mounted Kernel Configuration File System.
hub # [   25.755759] systemd-journald[294]: Received client request to flush runtime journal.
hub # [   27.808793] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
hub # [   27.829832] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console
hub # [   27.845527] ACPI: button: Power Button [PWRF]
hub # [   27.902088] mousedev: PS/2 mouse device common for all mice
hub # [   28.034597] Console: switching to colour dummy device 80x25
hub # [   28.036902] [drm] Found bochs VGA, ID 0xb0c5.
hub # [   28.036904] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
hub # [   28.048195] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic
hub # [   28.049515] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0
hub: Guest root shell did not produce any data yet...
hub:   To debug, enter the VM and run 'systemctl status backdoor.service'.
hub # [   28.175805] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized
hub # [   28.189379] rtc_cmos 00:04: RTC can wake from S4
hub # [   28.217334] rtc_cmos 00:04: registered as rtc0
hub # [   28.217651] rtc_cmos 00:04: setting system clock to 2026-08-30T18:04:19 UTC (1788113059)
hub # [   28.217762] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
hub # [   28.269891] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4
hub # [   28.272905] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
hub # [   28.273918] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
hub # [   28.275634] parport_pc 00:02: reported by Plug and Play ACPI
hub # [   28.275750] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
hub # [   28.330945] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6
hub # [   28.331805] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5
hub # [   28.368842] Console: switching to colour frame buffer device 160x50
hub # [   28.617381] ppdev: user-space parallel port driver
hub # [   28.620322] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)
hub # [   28.623247] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0)
hub # [   28.663673] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device
hub # [   29.031761] kvm_amd: TSC scaling supported
hub # [   29.040476] kvm_amd: Nested Virtualization enabled
hub # [   29.047975] kvm_amd: Nested Paging enabled
hub # [   29.049370] kvm_amd: LBR virtualization supported
hub # [   29.050861] kvm_amd: Virtual VMLOAD VMSAVE supported
hub # [   29.058606] kvm_amd: Virtual GIF supported
hub # [   29.159496] EDAC MC: Ver: 3.0.0
worker # [   31.252368] NET: Registered PF_VSOCK protocol family
hub # [   32.105770] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
hub # [   32.108673] systemd[1]: Starting Create Static Device Nodes in /dev...
hub # [   32.110863] systemd[1]: Finished Apply Kernel Variables.
hub # [   32.116723] systemd[1]: Finished Create Static Device Nodes in /dev.
hub # [   32.118813] systemd[1]: Reached target Preparation for Local File Systems.
hub # [   32.121445] systemd[1]: Starting Rule-based Manager for Device Events and Files...
hub # [   32.125975] systemd[1]: Mounting /run/wrappers...
hub # [   32.132178] systemd[1]: Mounted /run/wrappers.
hub # [   32.135601] systemd[1]: Reached target Local File Systems.
hub # [   32.140455] systemd-udevd[326]: Using default interface naming scheme 'v261'.
hub # [   32.143687] systemd[1]: Listening on Boot Loader Control Service Socket.
hub # [   32.147598] systemd[1]: Starting register-nix-paths.service...
hub # [   32.150286] systemd[1]: Starting Create SUID/SGID Wrappers...
hub # [   32.153581] systemd[1]: Started Rule-based Manager for Device Events and Files.
hub # [   32.157637] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
hub # [   32.161616] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
hub # [   32.163617] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.
hub # [   32.167525] (udev-worker)[383]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
hub # [   32.172337] (udev-worker)[383]: Network interface NamePolicy= disabled on kernel command line.
hub # [   32.176503] (udev-worker)[376]: Network interface NamePolicy= disabled on kernel command line.
hub # [   32.180495] systemd[1]: Condition check resulted in Virtio network device being skipped.
hub # [   32.185350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
hub # [   32.189931] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
hub # [   32.196929] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
hub # [   32.207231] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
hub # [   32.209883] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
hub # [   32.212783] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
hub # [   32.214758] systemd[1]: Finished Create SUID/SGID Wrappers.
hub # [   32.218837] systemd[1]: Starting Virtual Console Setup...
hub # [   32.220979] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
hub # [   32.226567] systemd[1]: Stopped Virtual Console Setup.
hub # [   32.228169] systemd[1]: Starting Virtual Console Setup...
hub # [   32.229876] systemd[1]: Finished Firewall.
hub # [   32.231705] systemd-vconsole-setup[468]: Configuration of first virtual console was skipped, ignoring remaining ones.
hub # [   32.235693] systemd[1]: Finished Virtual Console Setup.
hub # [   32.237426] systemd[1]: Finished Load/Save OS Random Seed.
hub # [   32.240118] systemd[1]: Reached target First Boot Complete.
hub # [   32.241540] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
hub # [   32.244476] systemd[1]: Starting Save Transient machine-id to Disk...
hub # [   32.247414] systemd[1]: Finished Flush Journal to Persistent Storage.
hub # [   32.250234] systemd[1]: Starting Create System Files and Directories...
worker # [   31.777086] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
worker # [   31.871904] systemd[1]: Detected virtualization kvm.
worker # [   31.891325] systemd[1]: Detected architecture x86-64.
worker # [   31.893149] systemd[1]: Detected first boot.
worker # [   31.923615] systemd[1]: Initializing machine ID from random generator.
hub # [   33.749837] systemd[1]: Finished Create System Files and Directories.
hub # [   33.776123] systemd[1]: Starting Rebuild Journal Catalog...
hub # [   33.794534] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
hub # [   34.047843] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
hub # [   34.365044] systemd[1]: Finished Rebuild Journal Catalog.
hub # [   34.613670] systemd[1]: Starting Update is Completed...
hub # [   35.142603] systemd[1]: Finished Update is Completed.
worker # [   39.662953] systemd[1]: bpf-restrict-fs: LSM BPF program attached
hub # [   40.878296] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
hub # [   40.888221] systemd[1]: Finished Save Transient machine-id to Disk.
worker # [   40.303199] systemd[1]: Applying preset policy.
hub # [   41.316161] systemd[1]: Finished register-nix-paths.service.
hub # [   41.318893] systemd[1]: Reached target System Initialization.
hub # [   41.385834] systemd[1]: Started Discard unused filesystem blocks once a week.
hub # [   41.435323] systemd[1]: Started Daily Cleanup of Temporary Directories.
hub # [   41.437995] systemd[1]: Reached target Timer Units.
hub # [   41.440103] systemd[1]: Listening on D-Bus System Message Bus Socket.
hub # [   41.441723] systemd[1]: Listening on Nix Daemon Socket.
hub # [   41.443547] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
hub # [   41.446268] systemd[1]: Reached target Socket Units.
hub # [   41.447778] systemd[1]: Reached target Basic System.
hub # [   41.482126] systemd[1]: Started backdoor.service.
hub # [   41.496118] systemd[1]: Starting Import lastlog data into lastlog2 database...
hub # [   41.517105] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
hub # [   41.536384] systemd[1]: Starting Post-Boot Actions...
hub # [   41.546471] systemd[1]: Started Reset console on configuration changes.
hub # [   41.591905] systemd[1]: Starting resolvconf update...
hub # [   41.634400] systemd[1]: Starting D-Bus System Message Bus...
hub # [   41.841138] systemd[1]: Finished Post-Boot Actions.
hub # connecting to host...
hub # [   41.942445] systemd[1]: Started Name Service Cache Daemon (nsncd).
hub # [   41.945072] nsncd[547]: Aug 30 18:04:33.473 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
hub # [   41.953707] systemd[1]: Reached target Host and Network Name Lookups.
hub # [   41.957755] systemd[1]: Reached target User and Group Name Lookups.
hub # [   41.970119] systemd[1]: Starting User Login Management...
hub # [   41.974138] systemd[1]: Finished Import lastlog data into lastlog2 database.
hub: Guest shell says: b'Spawning backdoor root shell...\n'
hub: connected to guest root shell
hub: (connecting took 44.35 seconds)
hub: (finished: waiting for the VM to finish booting, in 44.35 seconds)
hub # [   42.276912] systemd[1]: Stopped target Host and Network Name Lookups.
hub # [   42.280684] systemd[1]: Stopping Host and Network Name Lookups...
hub # [   42.283275] systemd[1]: Stopped target User and Group Name Lookups.
hub # [   42.284887] systemd[1]: Stopping User and Group Name Lookups...
hub # [   42.286884] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
hub # [   42.289237] systemd-logind[573]: New seat seat0.
hub # [   42.295857] systemd-logind[573]: Watching system buttons on /dev/input/event2 (Power Button)
hub # [   42.297651] systemd-logind[573]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
hub # [   42.300221] systemd-logind[573]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
hub # [   42.303064] systemd[1]: nscd.service: Deactivated successfully.
hub # [   42.309412] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
hub # [   42.323184] systemd[1]: Started User Login Management.
hub # [   42.341688] systemd[1]: Starting linger-users.service...
hub # [   42.351867] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
hub # [   42.362159] dbus-broker-launch[552]: Looking up NSS user entry for 'systemd-timesync'...
hub # [   42.391504] dbus-broker-launch[552]: NSS returned no entry for 'systemd-timesync'
hub # [   42.395554] dbus-broker-launch[552]: Invalid user-name in /nix/store/3bskr4xy146r1xiyk60mrbw2iv5nzzy6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
hub # [   42.515781] nsncd[624]: Aug 30 18:04:34.049 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
hub # [   42.737420] dbus-broker-launch[552]: Ready
hub # [   42.927448] systemd[1]: Started Name Service Cache Daemon (nsncd).
hub # [   42.931293] systemd[1]: Started D-Bus System Message Bus.
hub # [   42.932711] systemd[1]: linger-users.service: Deactivated successfully.
hub # [   42.935283] systemd[1]: Finished linger-users.service.
hub # [   42.966843] systemd[1]: Reached target Host and Network Name Lookups.
hub # [   42.969848] systemd[1]: Reached target User and Group Name Lookups.
hub # [   43.103889] systemd[1]: Finished resolvconf update.
hub # [   43.106368] systemd[1]: Reached target Preparation for Network.
hub # [   43.125173] systemd[1]: Starting DHCP Client...
hub # [   43.137689] systemd[1]: Starting Address configuration of eth1...
hub # [   43.167627] systemd[1]: Starting Extra networking commands....
hub # [   44.269576] network-addresses-eth1-start[655]: adding address 192.168.1.1/24... done
hub # [   44.326182] dhcpcd[678]: dhcpcd-10.3.2 starting
hub # [   44.351132] network-addresses-eth1-start[655]: adding address 2001:db8:1::1/64... done
hub # [   44.371864] dhcpcd[726]: dev: loaded udev
hub # [   44.437569] systemd[1]: Finished Address configuration of eth1.
hub # [   44.542478] systemd[1]: Finished Extra networking commands..
hub # [   44.551669] systemd[1]: Reached target Network.
hub # [   44.570291] systemd[1]: Starting Permit User Sessions...
hub # [   44.895310] 8021q: 802.1Q VLAN Support v1.8
hub # [   44.906622] 8021q: adding VLAN 0 to HW filter on device eth1
hub # [   45.028399] systemd[1]: Finished Permit User Sessions.
hub # [   45.068742] systemd[1]: Started Getty on tty1.
hub # [   45.094671] systemd[1]: Reached target Login Prompts.
hub # [   45.422950] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
hub # [   45.880728] cfg80211: Loading compiled-in X.509 certificates for regulatory database
hub # [   46.112369] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
hub # [   46.114469] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
hub # [   46.124757] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
hub # [   46.127360] cfg80211: failed to load regulatory.db
hub # [   46.433733] 8021q: adding VLAN 0 to HW filter on device eth0
hub # [   46.191888] dhcpcd[726]: eth0: waiting for carrier
hub # [   46.194709] dhcpcd[726]: eth0: carrier acquired
hub # [   46.384688] dhcpcd[726]: DUID 00:01:00:01:32:27:2d:35:52:54:00:12:34:56
hub # [   46.386223] dhcpcd[726]: eth0: IAID 00:12:34:56
hub # [   46.428382] dhcpcd[726]: eth0: adding address fe80::5054:ff:fe12:3456
hub # [   47.004339] dhcpcd[726]: eth0: soliciting a DHCP lease
worker # [   46.463663] systemd[1]: Populated /etc with preset unit settings.
hub # [   47.533735] NET: Registered PF_PACKET protocol family
hub # [   47.373341] dhcpcd[726]: eth0: offered 10.0.2.15 from 10.0.2.2
hub # [   47.411572] dhcpcd[726]: eth0: probing address 10.0.2.15/24
hub # [   48.922164] dhcpcd[726]: eth0: soliciting an IPv6 router
hub # [   48.924091] dhcpcd[726]: eth0: Router Advertisement from fe80::2
hub # [   48.925566] dhcpcd[726]: eth0: adding address fec0::5054:ff:fe12:3456/64
hub # [   48.926885] dhcpcd[726]: eth0: adding route to fec0::/64
hub # [   48.928965] dhcpcd[726]: eth0: adding default route via fe80::2
hub # [   52.108406] dhcpcd[726]: eth0: leased 10.0.2.15 for 86400 seconds
hub # [   52.112508] dhcpcd[726]: eth0: adding route to 10.0.2.0/24
hub # [   52.114372] dhcpcd[726]: eth0: adding default route via 10.0.2.2
hub # [   52.352437] systemd[1]: Started DHCP Client.
worker # [   51.623066] systemd[1]: initrd-switch-root.service: Deactivated successfully.
worker # [   51.625481] systemd[1]: Stopped initrd-switch-root.service.
hub # [   52.356844] systemd[1]: Reached target Multi-User System.
hub # [   52.358968] systemd[1]: Startup finished in 3.107s (kernel) + 7.268s (initrd) + 41.983s (userspace) = 52.358s.
worker # [   51.630264] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
worker # [   51.639591] systemd[1]: Created slice Slice /system/getty.
worker # [   51.641627] systemd[1]: Created slice User and Session Slice.
worker # [   51.643119] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
worker # [   51.645006] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
worker # [   51.646807] systemd[1]: Expecting device /dev/hvc0...
worker # [   51.648117] systemd[1]: Expecting device /dev/ttyS0...
worker # [   51.650041] systemd[1]: Reached target Local Encrypted Volumes.
worker # [   51.651604] systemd[1]: Stopped target initrd-fs.target.
worker # [   51.653858] systemd[1]: Stopped target initrd-root-fs.target.
worker # [   51.655424] systemd[1]: Stopped target initrd-switch-root.target.
worker # [   51.656830] systemd[1]: Reached target Virtual Machines and Containers.
worker # [   51.658459] systemd[1]: Reached target Path Units.
worker # [   51.659716] systemd[1]: Reached target Remote File Systems.
worker # [   51.661034] systemd[1]: Reached target Slice Units.
worker # [   51.662259] systemd[1]: Reached target Swaps.
worker # [   51.668958] systemd[1]: Listening on Query the User Interactively for a Password.
worker # [   51.676681] systemd[1]: Listening on Process Core Dump Socket.
worker # [   51.722572] systemd[1]: Listening on Credential Encryption/Decryption.
worker # [   51.737856] systemd[1]: Listening on Factory Reset Management.
worker # [   51.740872] systemd[1]: Listening on Hostname Service Socket.
worker # [   51.748068] systemd[1]: Starting Journal Log Access Socket...
worker # [   51.750515] systemd[1]: Listening on Journal Audit Socket.
worker # [   51.761759] systemd[1]: Listening on Console Output Muting Service Socket.
worker # [   51.764431] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
worker # [   51.768524] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os
worker # [   51.771865] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
worker # [   51.809408] systemd[1]: Listening on Disk Repartitioning Service Socket.
worker # [   51.811191] systemd[1]: Listening on udev Control Socket.
worker # [   51.813018] systemd[1]: Listening on udev Varlink Socket.
worker # [   51.828429] systemd[1]: Mounting Huge Pages File System...
worker # [   51.838812] systemd[1]: Mounting POSIX Message Queue File System...
worker # [   51.844278] systemd[1]: Mounting Kernel Debug File System...
worker # [   51.861969] systemd[1]: Mounting Kernel Trace File System...
worker # [   51.876934] systemd[1]: Starting Create List of Static Device Nodes...
worker # [   51.878594] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
worker # [   51.884319] systemd[1]: Starting Load Kernel Module configfs...
worker # [   51.885749] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
worker # [   51.887790] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
worker # [   51.890121] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
worker # [   51.898450] systemd[1]: Mounting FUSE Control File System...
worker # [   51.902561] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
worker # [   51.939508] systemd[1]: Starting Journal Service...
worker # [   51.948813] systemd[1]: Starting Load Kernel Modules...
worker # [   51.984874] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
worker # [   52.018599] systemd[1]: Starting Remount Root and Kernel File Systems...
worker # [   52.026036] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
worker # [   52.042638] systemd[1]: Starting Coldplug All udev Devices...
worker # [   52.050027] systemd[1]: Listening on Journal Log Access Socket.
worker # [   52.090960] systemd[1]: Mounted Huge Pages File System.
worker # [   52.093275] systemd[1]: Mounted POSIX Message Queue File System.
worker # [   52.094959] systemd[1]: Mounted Kernel Debug File System.
worker # [   52.096772] systemd[1]: Mounted Kernel Trace File System.
worker # [   52.099183] systemd[1]: Mounted FUSE Control File System.
worker # [   52.131184] systemd[1]: Finished Create List of Static Device Nodes.
worker # [   52.137829] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
worker # [   52.163999] systemd-journald[299]: Collecting audit messages is enabled.
worker # [   52.172804] systemd[1]: modprobe@configfs.service: Deactivated successfully.
worker # [   52.179544] systemd[1]: Finished Load Kernel Module configfs.
worker # [   52.185740] EXT4-fs (vda): re-mounted 069a48ed-e3fd-4109-b8d3-6a0d9ac6a677.
worker # [   52.190643] systemd[1]: Mounting Kernel Configuration File System...
worker # [   52.207481] systemd[1]: Finished Remount Root and Kernel File Systems.
worker # [   52.210892] systemd[1]: Listening on Disk Image Download Service Socket.
worker # [   52.215512] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
worker # [   52.229705] systemd[1]: Starting Load/Save OS Random Seed...
worker # [   52.232609] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
worker # [   52.270313] systemd[1]: Mounted Kernel Configuration File System.
worker # [   52.294174] systemd[1]: Started Journal Service.
worker # [   52.042493] systemd[1]: Queued start job for default target Multi-User System.[   52.301957] loop: module loaded
worker # 
worker # [   52.048958] systemd[1]: systemd-journald.service: Deactivated successfully.
hub: (finished: waiting for unit multi-user.target, in 55.23 seconds)
worker: waiting for unit multi-user.target
worker # [   52.060316] systemd[1]: Starting Flush Journal to Persistent Storage...
worker: waiting for the VM to finish booting
worker # [   52.073804] systemd-modules-load[300]: Inserted module 'loop'
worker # [   52.075797] systemd[1]: Finished Load Kernel Modules.
worker # [   52.083405] systemd[1]: Starting Firewall...
worker # [   52.095213] systemd[1]: Starting Apply Kernel Variables...
worker # [   52.140198] systemd[1]: Finished Load/Save OS Random Seed.
worker # [   52.143289] systemd[1]: Reached target First Boot Complete.
worker # [   52.146605] systemd-oomd[301]: No swap; memory pressure usage will be degraded
worker # [   52.175051] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
worker # [   52.440775] systemd-journald[299]: Received client request to flush runtime journal.
worker # [   52.480554] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
worker # [   52.489612] systemd[1]: Starting Create Static Device Nodes in /dev...
worker # [   52.501700] systemd[1]: Finished Apply Kernel Variables.
worker # [   52.506144] systemd[1]: Finished Create Static Device Nodes in /dev.
worker # [   52.509816] systemd[1]: Reached target Preparation for Local File Systems.
worker # [   52.514306] systemd[1]: Mounting /run/wrappers...
worker # [   52.518409] systemd[1]: Starting Rule-based Manager for Device Events and Files...
worker # [   52.522559] systemd[1]: Finished Flush Journal to Persistent Storage.
worker # [   52.527888] systemd[1]: Mounted /run/wrappers.
worker # [   52.532355] systemd[1]: Reached target Local File Systems.
worker # [   52.536505] systemd[1]: Listening on Boot Loader Control Service Socket.
worker # [   52.540599] systemd[1]: Starting register-nix-paths.service...
worker # [   52.550356] systemd[1]: Starting Create SUID/SGID Wrappers...
worker # [   52.553847] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
worker # [   52.556345] systemd[1]: Starting Save Transient machine-id to Disk...
worker # [   52.561745] systemd[1]: Starting Create System Files and Directories...
worker # [   52.583829] systemd[1]: Finished Coldplug All udev Devices.
worker # [   52.662619] systemd-udevd[333]: Using default interface naming scheme 'v261'.
worker # [   52.677409] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
worker # [   52.683583] systemd[1]: Finished Save Transient machine-id to Disk.
worker # [   52.742181] systemd[1]: Finished Create System Files and Directories.
worker # [   52.749150] systemd[1]: Starting Rebuild Journal Catalog...
worker # [   52.754906] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
worker # [   52.854314] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
worker # [   52.931610] systemd[1]: Finished Rebuild Journal Catalog.
worker # [   52.937625] systemd[1]: Starting Update is Completed...
worker # [   52.945272] systemd[1]: Started Rule-based Manager for Device Events and Files.
worker # [   53.008856] systemd[1]: Finished Update is Completed.
worker # [   53.253934] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
worker # [   53.360845] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
worker # [   53.426966] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.
worker # [   53.492556] (udev-worker)[416]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
worker # [   53.498820] (udev-worker)[416]: Network interface NamePolicy= disabled on kernel command line.
worker # [   53.502070] (udev-worker)[424]: Network interface NamePolicy= disabled on kernel command line.
worker # [   53.676073] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
worker # [   53.678671] systemd[1]: Finished Create SUID/SGID Wrappers.
worker # [   53.746646] systemd[1]: Condition check resulted in Virtio network device being skipped.
worker # [   53.748765] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
worker # [   53.754092] systemd[1]: Starting Create SUID/SGID Wrappers...
worker # [   53.756240] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
worker # [   53.758655] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
worker # [   53.761977] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
worker # [   53.765687] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
worker # [   53.769242] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os
worker # [   54.058305] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console
worker # [   54.063650] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
worker # [   54.118681] ACPI: button: Power Button [PWRF]
worker # [   54.156391] Console: switching to colour dummy device 80x25
worker # [   54.215026] [drm] Found bochs VGA, ID 0xb0c5.
worker # [   54.215032] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
worker # [   54.221544] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic
worker # [   54.222691] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0
worker # [   54.239819] mousedev: PS/2 mouse device common for all mice
worker # [   54.282869] rtc_cmos 00:04: RTC can wake from S4
worker # [   54.325059] rtc_cmos 00:04: registered as rtc0
worker # [   54.327247] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized
worker # [   54.350023] rtc_cmos 00:04: setting system clock to 2026-08-30T18:04:47 UTC (1788113087)
worker # [   54.355224] parport_pc 00:02: reported by Plug and Play ACPI
worker # [   54.373230] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4
worker # [   54.390843] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
worker # [   54.408422] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
worker # [   54.431347] systemd[1]: Finished register-nix-paths.service.
worker # [   54.697999] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
worker # [   54.698129] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
worker # [   54.705251] Console: switching to colour frame buffer device 160x50
worker # [   54.739750] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6
worker # [   54.740134] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5
worker # [   54.581657] systemd[1]: Finished Firewall.
worker # [   54.860372] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device
worker # [   54.651156] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
worker # [   54.653795] systemd[1]: Finished Create SUID/SGID Wrappers.
worker # [   54.657529] systemd[1]: Reached target System Initialization.
worker # [   54.661341] systemd[1]: Started Discard unused filesystem blocks once a week.
worker # [   54.663794] systemd[1]: Started Daily Cleanup of Temporary Directories.
worker # [   54.667046] systemd[1]: Reached target Timer Units.
worker # [   54.671684] systemd[1]: Listening on D-Bus System Message Bus Socket.
worker # [   54.673880] systemd[1]: Listening on Nix Daemon Socket.
worker # [   54.675726] systemd[1]: Starting Podman API Socket...
worker # [   54.679685] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
worker # [   54.684224] systemd[1]: Starting D-Bus System Message Bus...
worker # [   54.686802] systemd[1]: Listening on Podman API Socket.
worker # [   54.688541] systemd[1]: Reached target Socket Units.
worker # [   54.742507] systemd[1]: Starting Virtual Console Setup...
worker # [   54.762141] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
worker # [   54.764295] systemd[1]: Stopped Virtual Console Setup.
worker # [   54.770136] systemd[1]: Starting Virtual Console Setup...
worker # [   55.085255] ppdev: user-space parallel port driver
worker # [   55.090083] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)
worker # [   54.853340] dbus-broker-launch[592]: Looking up NSS user entry for 'systemd-timesync'...
worker # [   54.863191] dbus-broker-launch[592]: NSS returned no entry for 'systemd-timesync'
worker # [   54.865564] dbus-broker-launch[592]: Invalid user-name in /nix/store/rjgassb9pkj56jfr5d844y2jlkfxx0rk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
worker # [   55.128210] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)
worker # [   54.899309] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
worker # [   54.903307] systemd[1]: Stopped Virtual Console Setup.
worker # [   54.907691] systemd[1]: Starting Virtual Console Setup...
worker # [   54.923371] systemd[1]: Started D-Bus System Message Bus.
worker # [   54.928518] systemd[1]: Reached target Basic System.
worker # [   54.933358] systemd[1]: Started backdoor.service.
worker # [   54.939114] systemd[1]: Starting Import lastlog data into lastlog2 database...
worker # [   54.946499] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
worker # [   54.954721] systemd[1]: Starting Post-Boot Actions...
worker # [   54.962971] systemd[1]: Started Reset console on configuration changes.
worker # [   54.974826] systemd[1]: Starting resolvconf update...
worker # [   55.066619] dbus-broker-launch[592]: Ready
worker # [   55.117104] systemd[1]: Finished Post-Boot Actions.
worker # connecting to host...
worker # [   55.216821] nsncd[603]: Aug 30 18:04:48.620 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
worker # [   55.220383] systemd[1]: Started Name Service Cache Daemon (nsncd).
worker # [   55.222813] systemd[1]: Reached target Host and Network Name Lookups.
worker # [   55.225222] systemd[1]: Reached target User and Group Name Lookups.
worker # [   55.240572] systemd[1]: Starting User Login Management...
worker # [   55.242174] systemd[1]: Finished Import lastlog data into lastlog2 database.
worker # [   55.536731] kvm_amd: TSC scaling supported
worker # [   55.537613] kvm_amd: Nested Virtualization enabled
worker # [   55.539085] kvm_amd: Nested Paging enabled
worker # [   55.540655] kvm_amd: LBR virtualization supported
worker # [   55.541907] kvm_amd: Virtual VMLOAD VMSAVE supported
worker # [   55.543036] kvm_amd: Virtual GIF supported
worker: Guest shell says: b'Spawning backdoor root shell...\n'
worker: connected to guest root shell
worker: (connecting took 3.25 seconds)
worker: (finished: waiting for the VM to finish booting, in 3.25 seconds)
worker # [   55.629753] EDAC MC: Ver: 3.0.0
worker # [   55.426537] systemd[1]: Stopped target Host and Network Name Lookups.
worker # [   55.429955] systemd[1]: Stopping Host and Network Name Lookups...
worker # [   55.433637] systemd[1]: Stopped target User and Group Name Lookups.
worker # [   55.435624] systemd[1]: Stopping User and Group Name Lookups...
worker # [   55.437490] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
worker # [   55.440435] systemd-logind[628]: New seat seat0.
worker # [   55.445437] systemd[1]: nscd.service: Deactivated successfully.
worker # [   55.447917] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
worker # [   55.461777] systemd-logind[628]: Watching system buttons on /dev/input/event2 (Power Button)
worker # [   55.463988] systemd-logind[628]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
worker # [   55.467274] systemd-logind[628]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
worker # [   55.474336] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
worker # [   55.476551] systemd[1]: Started User Login Management.
worker # [   55.484445] systemd[1]: Starting linger-users.service...
worker # [   55.604948] nsncd[677]: Aug 30 18:04:49.011 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
worker # [   55.906201] systemd[1]: Started Name Service Cache Daemon (nsncd).
worker # [   55.912395] systemd[1]: linger-users.service: Deactivated successfully.
worker # [   55.915467] systemd[1]: Finished linger-users.service.
worker # [   55.926256] systemd[1]: Reached target Host and Network Name Lookups.
worker # [   55.928471] systemd[1]: Reached target User and Group Name Lookups.
worker # [   55.985698] systemd[1]: Finished resolvconf update.
worker # [   55.988681] systemd[1]: Reached target Preparation for Network.
worker # [   56.005854] systemd[1]: Starting DHCP Client...
worker # [   56.015073] systemd[1]: Starting Address configuration of eth1...
worker # [   56.022311] systemd[1]: Starting Extra networking commands....
worker # [   56.375646] network-addresses-eth1-start[711]: adding address 192.168.1.2/24... done
worker # [   56.468997] dhcpcd[719]: dhcpcd-10.3.2 starting
worker # [   56.485773] network-addresses-eth1-start[711]: adding address 2001:db8:1::2/64... done
worker # [   56.527620] dhcpcd[762]: dev: loaded udev
worker # [   56.573200] systemd[1]: Finished Address configuration of eth1.
worker # [   56.702495] systemd[1]: Finished Extra networking commands..
worker # [   56.705838] systemd[1]: Reached target Network.
worker # [   56.973785] 8021q: 802.1Q VLAN Support v1.8
worker # [   56.718693] systemd[1]: Starting Permit User Sessions...
worker # [   56.977627] 8021q: adding VLAN 0 to HW filter on device eth1
worker # [   56.884656] systemd[1]: Finished Permit User Sessions.
worker # [   56.903322] systemd[1]: Started Getty on tty1.
worker # [   56.906768] systemd[1]: Reached target Login Prompts.
worker # [   57.263481] cfg80211: Loading compiled-in X.509 certificates for regulatory database
worker # [   57.200512] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
worker # [   57.475427] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
worker # [   57.477498] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
worker # [   57.515598] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
worker # [   57.518780] cfg80211: failed to load regulatory.db
worker # [   58.280490] 8021q: adding VLAN 0 to HW filter on device eth0
worker # [   58.030120] dhcpcd[762]: eth0: waiting for carrier
worker # [   58.033534] dhcpcd[762]: eth0: carrier acquired
worker # [   58.090493] dhcpcd[762]: DUID 00:01:00:01:32:27:2d:43:52:54:00:12:34:56
worker # [   58.093301] dhcpcd[762]: eth0: IAID 00:12:34:56
worker # [   58.097092] dhcpcd[762]: eth0: adding address fe80::5054:ff:fe12:3456
worker # [   58.143390] systemd-vconsole-setup[599]: Configuration of first virtual console was skipped, ignoring remaining ones.
worker # [   58.151441] systemd[1]: Finished Virtual Console Setup.
worker # [   59.609950] dhcpcd[762]: eth0: soliciting a DHCP lease
worker # [   59.911352] NET: Registered PF_PACKET protocol family
worker # [   59.662895] dhcpcd[762]: eth0: offered 10.0.2.15 from 10.0.2.2
worker # [   59.665270] dhcpcd[762]: eth0: probing address 10.0.2.15/24
worker # [   59.731900] dhcpcd[762]: eth0: soliciting an IPv6 router
worker # [   59.735439] dhcpcd[762]: eth0: Router Advertisement from fe80::2
worker # [   59.736968] dhcpcd[762]: eth0: adding address fec0::5054:ff:fe12:3456/64
worker # [   59.738766] dhcpcd[762]: eth0: adding route to fec0::/64
worker # [   59.740215] dhcpcd[762]: eth0: adding default route via fe80::2
worker # [   64.377473] dhcpcd[762]: eth0: leased 10.0.2.15 for 86400 seconds
worker # [   64.379538] dhcpcd[762]: eth0: adding route to 10.0.2.0/24
worker # [   64.383833] dhcpcd[762]: eth0: adding default route via 10.0.2.2
worker # [   64.504884] systemd[1]: Started DHCP Client.
worker # [   64.507890] systemd[1]: Reached target Multi-User System.
worker # [   64.509248] systemd[1]: Startup finished in 1.483s (kernel) + 29.429s (initrd) + 33.593s (userspace) = 1min 4.507s.
worker: (finished: waiting for unit multi-user.target, in 12.74 seconds)
subtest: certificate authority
hub: must succeed: tribuchet ca init --dir /root/ca
hub: (finished: must succeed: tribuchet ca init --dir /root/ca, in 1.79 seconds)
hub: must succeed: tribuchet ca issue hub --dir /root/ca
hub: (finished: must succeed: tribuchet ca issue hub --dir /root/ca, in 5.53 seconds)
hub: must succeed: tribuchet ca issue worker --dir /root/ca
hub: (finished: must succeed: tribuchet ca issue worker --dir /root/ca, in 0.10 seconds)
hub: must succeed: mkdir -p /etc/tribuchet/ca
hub: (finished: must succeed: mkdir -p /etc/tribuchet/ca, in 0.04 seconds)
hub: must succeed: cp /root/ca/hub.crt /root/ca/hub.key /root/ca/ca.crt /etc/tribuchet/ca/
hub: (finished: must succeed: cp /root/ca/hub.crt /root/ca/hub.key /root/ca/ca.crt /etc/tribuchet/ca/, in 0.04 seconds)
worker: must succeed: mkdir -p /root/tls
worker: (finished: must succeed: mkdir -p /root/tls, in 0.05 seconds)
hub: must succeed: cat /root/ca/worker.crt
hub: (finished: must succeed: cat /root/ca/worker.crt, in 0.05 seconds)
worker: must succeed: cat > /root/tls/worker.crt << 'PEMEOF'
-----BEGIN CERTIFICATE-----
MIIBVzCB/6ADAgECAhQIAmkk5kcSHOpgSvbZwTZAHTkVTzAKBggqhkjOPQQDAjAh
MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDgzMDE4MDUw
NFoXDTI4MDgyOTE4MDUwNFowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg
Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABAgsQb5XUVui+xxPD3PXII3I
6dT4wDBRp9+irXlKpEv1g9kwtLJc4sjmjh/556SapgYwWwN+qmQ3cqn1ihUD0N+j
FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNHADBEAiAJhUjfPI0f
lA0lXpvQnxJ/DOqYdV+oa62otxKQ3EtwYgIgYicwIvYV7QrQcNEznamlX3K56bfx
0Ouu4KCbRr+otM0=
-----END CERTIFICATE-----
PEMEOF
worker: (finished: must succeed: cat > /root/tls/worker.crt << 'PEMEOF'
-----BEGIN CERTIFICATE-----
MIIBVzCB/6ADAgECAhQIAmkk5kcSHOpgSvbZwTZAHTkVTzAKBggqhkjOPQQDAjAh
MR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MB4XDTI2MDgzMDE4MDUw
NFoXDTI4MDgyOTE4MDUwNFowITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQg
Y2VydDBZMBMGByqGSM49AgEGCCqGSM49AwEHA0IABAgsQb5XUVui+xxPD3PXII3I
6dT4wDBRp9+irXlKpEv1g9kwtLJc4sjmjh/556SapgYwWwN+qmQ3cqn1ihUD0N+j
FTATMBEGA1UdEQQKMAiCBndvcmtlcjAKBggqhkjOPQQDAgNHADBEAiAJhUjfPI0f
lA0lXpvQnxJ/DOqYdV+oa62otxKQ3EtwYgIgYicwIvYV7QrQcNEznamlX3K56bfx
0Ouu4KCbRr+otM0=
-----END CERTIFICATE-----
PEMEOF, in 0.03 seconds)
hub: must succeed: cat /root/ca/worker.key
hub: (finished: must succeed: cat /root/ca/worker.key, in 0.03 seconds)
worker: must succeed: cat > /root/tls/worker.key << 'PEMEOF'
-----BEGIN PRIVATE KEY-----
MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgMj4BRNceKfs9Khpm
n4XFdPAz5StgT15gut01u6cmEbWhRANCAAQILEG+V1FbovscTw9z1yCNyOnU+MAw
Uaffoq15SqRL9YPZMLSyXOLI5o4f+eekmqYGMFsDfqpkN3Kp9YoVA9Df
-----END PRIVATE KEY-----
PEMEOF
worker: (finished: must succeed: cat > /root/tls/worker.key << 'PEMEOF'
-----BEGIN PRIVATE KEY-----
MIGHAgEAMBMGByqGSM49AgEGCCqGSM49AwEHBG0wawIBAQQgMj4BRNceKfs9Khpm
n4XFdPAz5StgT15gut01u6cmEbWhRANCAAQILEG+V1FbovscTw9z1yCNyOnU+MAw
Uaffoq15SqRL9YPZMLSyXOLI5o4f+eekmqYGMFsDfqpkN3Kp9YoVA9Df
-----END PRIVATE KEY-----
PEMEOF, in 0.03 seconds)
hub: must succeed: cat /root/ca/ca.crt
hub: (finished: must succeed: cat /root/ca/ca.crt, in 0.05 seconds)
worker: must succeed: cat > /root/tls/ca.crt << 'PEMEOF'
-----BEGIN CERTIFICATE-----
MIIBjzCCATWgAwIBAgIUXZXI0o5RFF1gR2YTw0wS0S4MPicwCgYIKoZIzj0EAwIw
ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA4MzAxODA0
NTdaFw0zNjA4MjcxODA0NTdaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk
IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQDsz6przQWN39vudWhkLOw
MYUbwPnAeaYCqGnQ5guMiMPy8emJcCz/OWdKN6rAKeAyk+2CK8gWIaRFGUrVdaoj
o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFJNgrKB/AnbC
kgGLSfkBjXlwB/7NMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIh
AICzG9b3qfxg5nqpoTqwgWNY5QJWlgVlHjp+2XmVbA6bAiBHvCpm0IArXoh9k0cm
rxg4ajSBG2hfRdScy8VJqXuEkQ==
-----END CERTIFICATE-----
PEMEOF
worker: (finished: must succeed: cat > /root/tls/ca.crt << 'PEMEOF'
-----BEGIN CERTIFICATE-----
MIIBjzCCATWgAwIBAgIUXZXI0o5RFF1gR2YTw0wS0S4MPicwCgYIKoZIzj0EAwIw
ITEfMB0GA1UEAwwWcmNnZW4gc2VsZiBzaWduZWQgY2VydDAeFw0yNjA4MzAxODA0
NTdaFw0zNjA4MjcxODA0NTdaMCExHzAdBgNVBAMMFnJjZ2VuIHNlbGYgc2lnbmVk
IGNlcnQwWTATBgcqhkjOPQIBBggqhkjOPQMBBwNCAAQDsz6przQWN39vudWhkLOw
MYUbwPnAeaYCqGnQ5guMiMPy8emJcCz/OWdKN6rAKeAyk+2CK8gWIaRFGUrVdaoj
o0swSTAXBgNVHREEEDAOggx0cmlidWNoZXQtY2EwHQYDVR0OBBYEFJNgrKB/AnbC
kgGLSfkBjXlwB/7NMA8GA1UdEwEB/wQFMAMBAf8wCgYIKoZIzj0EAwIDSAAwRQIh
AICzG9b3qfxg5nqpoTqwgWNY5QJWlgVlHjp+2XmVbA6bAiBHvCpm0IArXoh9k0cm
rxg4ajSBG2hfRdScy8VJqXuEkQ==
-----END CERTIFICATE-----
PEMEOF, in 0.08 seconds)
(finished: subtest: certificate authority, in 7.82 seconds)
subtest: containerized worker registers at the hub
hub: must succeed: systemctl start tribuchet-hub.socket
hub # [   73.677528] systemd[1]: Starting tribuchet-hub.socket...
hub # [   73.687512] systemd[1]: Listening on tribuchet-hub.socket.
hub: (finished: must succeed: systemctl start tribuchet-hub.socket, in 0.09 seconds)
hub: must succeed: systemctl start tribuchet-hub
hub # [   73.746388] systemd[1]: Starting tribuchet-hub.service...
hub # [   73.817841] tribuchet[908]: 2026-08-30T18:05:05.350584Z  INFO tribuchet::sd: adopted activated sockets tcp=true unix=true
hub # [   73.833729] tribuchet[908]: 2026-08-30T18:05:05.367780Z  INFO tribuchet::hub::serve: hub running listen="0.0.0.0:7437" socket=/run/tribuchet/hub.sock
hub # [   73.838968] systemd[1]: Started tribuchet-hub.service.
hub: (finished: must succeed: systemctl start tribuchet-hub, in 0.15 seconds)
worker: must succeed: systemctl start podman-worker
worker # [   72.905260] systemd[1]: Starting podman-worker.service...
worker # [   81.051453] systemd[1]: var-lib-containers-storage-overlay-compat2533915495-merged.mount: Deactivated successfully.
worker # [   93.784438] systemd[1]: var-lib-containers-storage-overlay-metacopy\x2dcheck3977223972-merged.mount: Deactivated successfully.
worker # [   94.456453] podman[945]: 2026-08-30 18:05:27.849407531 +0000 UTC m=+21.341614086 system refresh
worker # [   94.484366] systemd[1]: var-lib-containers-storage-overlay.mount: Deactivated successfully.
worker # [  119.873198] pre-start[957]: Getting image source signatures
worker # [  119.879352] pre-start[957]: Copying blob sha256:511898adcd2460e32d578f0c37b686f647ad4c6cc0099ea400af6e1aa86fd5aa
worker # [  119.885556] pre-start[957]: Copying blob sha256:2a951723bb43a3a0499aa8eadfc318adf001448a990a7508feb011d9c23fb744
worker # [  119.889111] pre-start[957]: Copying blob sha256:9f5af8873fab668f11952b3643cf1b110ca91d6865e2bc4fb15be6538d655670
worker # [  119.891426] pre-start[957]: Copying blob sha256:81e2ee39edfa447871f230a77d94333af9e060f916a6b49c4b0cf2c9a7a7ab85
worker # [  119.893751] pre-start[957]: Copying blob sha256:5489f86220c0abbc211189deee40fe3aa5a485d08a774041075cffdecca3bd70
worker # [  119.896904] pre-start[957]: Copying blob sha256:b2cf7d98634cc5aedd8f7f19097c866a998ed64a2e2d1023b9a6cdd6208cf5e6
worker # [  120.226392] systemd[1]: var-lib-containers-storage-overlay-compat606288098-merged.mount: Deactivated successfully.
worker # [  123.579315] systemd[1]: var-lib-containers-storage-overlay-compat606288098-lower\x2dmapped.mount: Deactivated successfully.
worker # [  123.782554] pre-start[957]: Copying blob sha256:a8e4e73c9c7c235c46b6895c077a98b99458c6200ee1914db5bfa6b528ddb2f3
worker # [  124.226126] pre-start[957]: Copying blob sha256:1201a0b6e0f1b21e51cc882ddab644616786b317ebc33515f0e14242685b3b76
worker # [  124.467151] pre-start[957]: Copying blob sha256:462b4696216e05de2a85aecf8468daa9eb9898a86523b65eddcccb9458ba062c
worker # [  124.628848] pre-start[957]: Copying blob sha256:824d5d655307c7df95e531bab29b0ef0b65ebe6588d489ebfde2376665e32f72
worker # [  124.795412] pre-start[957]: Copying blob sha256:8b1f28a9feb73f188b22d1c55c56a25e7c5c29621bab661f610afa44e23632c6
worker # [  124.970125] pre-start[957]: Copying blob sha256:8836058b6c2df8b4a1dffbee3ad2afcade1660b726715f1915d0206eff118e3f
worker # [  125.121538] pre-start[957]: Copying blob sha256:08ddcafd54c539600a433e4a9e95aef0cae82fa0f5ea710207b67b5aefce06f9
worker # [  125.401542] pre-start[957]: Copying blob sha256:98ab75564f746c6fdc620887b8f88a244c34f34f29f7ea2bd73ef10c83e632ea
worker # [  125.669200] pre-start[957]: Copying blob sha256:f8f26f6f0c7d3748a9e79f28b92d1a439fb73a8ca74238e3913d25dbedb14f21
worker # [  125.912644] pre-start[957]: Copying blob sha256:4c3f48f5017f8c64a34ee6d68515f5988687e766b0346a86df07da0303e4095e
worker # [  125.991201] pre-start[957]: Copying blob sha256:c8ae780eaeff8dd72248797777fbd91a786c6e80bb8e35565308d5aa52c442b7
worker # [  126.162118] pre-start[957]: Copying blob sha256:3b8c30e7c813dc3504b869251faab7d85d5ba19ab1e07bbf127a33bb33168fdc
worker # [  134.363714] pre-start[957]: Copying blob sha256:d951f50d70c9b161f241e1beaf600c5aaaeb508d4df05d812968e6323d055cdc
worker # [  135.767029] pre-start[957]: Copying blob sha256:6819c55209ce74cd0fa41ddce000b05d2d9e191ebf9db5be4e5a8dbda3adac7a
worker # [  140.791167] pre-start[957]: Copying blob sha256:8d76e722f69f242842f35d2409a06cf8585f3a263be9fe19c8c5d185271f3e54
worker # [  141.091276] pre-start[957]: Copying blob sha256:f99bfe9072ee389c41ec72d664140634c72130219f100dfc9a5212cc8c74c3cd
worker # [  169.928927] pre-start[957]: Copying blob sha256:e71e49b3e02d5aab8b5c873e6de974317a00b2c9faf03a3424e783f82a13c5d4
worker # [  180.027407] pre-start[957]: Copying blob sha256:4bab923f1a3c1e306a52722a2ca879cbaba5f86b62264a2949198ed17c04c1db
worker # [  181.619786] pre-start[957]: Copying blob sha256:60af93670ca9c144c43ee510538801ba55a44c2ea49cdd648789d0b59e119284
worker # [  181.787989] pre-start[957]: Copying blob sha256:e704eed63f2288fa376c2907caed1ab1f1222f5e4f96cdea3618822419c6cb8d
worker # [  181.935810] pre-start[957]: Copying blob sha256:fde1867995ed50cb6e65f1a7cf151240a002ac08275b87b97bf5ff81afd721b4
worker # [  182.203418] pre-start[957]: Copying blob sha256:3fb75b8f0c8fcd1bb714f7efc93b4bba407b37480ac2d94c3eb79fde44044758
worker # [  182.456219] pre-start[957]: Copying blob sha256:e67ae6587e6e1c60b14bad3cfbf0fead772b993b1414b5764c617d0bded1187b
worker # [  182.831600] pre-start[957]: Copying blob sha256:66d234331c272f79268eeae3ea12151709bd5a254028ac9b8977118d68dea3ae
worker # [  183.204753] pre-start[957]: Copying blob sha256:30db0c02878cebe69723b8b3eb9f7129170b30388d078d374899bba21763d048
worker # [  183.824110] pre-start[957]: Copying blob sha256:e1db4c157c26e04a2c2838e0f871e4fc866a15080ab921fccc706c2f1653a39f
worker # [  184.072738] pre-start[957]: Copying blob sha256:aa96bf3c08291010b5e7a6840cb510996ddaa7dbf967a912331206ba7d3e6f94
worker # [  184.143172] pre-start[957]: Copying blob sha256:851ee52bf08b3183b831b433ecb54317525c25a2e2fe7cf29b11bbf4bb0cd776
worker # [  184.553574] pre-start[957]: Copying blob sha256:ad8f303eb34c9d17c49b2458d5b15c2ea55b866ea57a244aacb116f260b44ab8
worker # [  197.447956] pre-start[957]: Copying blob sha256:409060d3a02471b68fc9841534c3210cd42d93aa29f7faccee3fa39009d8c98a
worker # [  197.748079] pre-start[957]: Copying blob sha256:9275f4f8e05e32425a4ec010591ab67cef108ae49f52eedabb40780872e73929
worker # [  197.750667] pre-start[957]: Copying blob sha256:4f3d062f388557b73f8ffcdacf57060a847ccfb747c44e77499878f7be6fdcc5
worker # [  199.451136] pre-start[957]: Copying blob sha256:a9462f5b018d1a1b7523434e3412244df67750148851879a9390f175b4e420a5
worker # [  206.303598] pre-start[957]: Copying blob sha256:e043367f6af3679fc8cd555efccf1468be0c6ddc46c29b1f9b8f4dd8f638ffc2
worker # [  206.758276] pre-start[957]: Copying blob sha256:20bd5cc9ccc3095972058d09e293381cacffb09f2427e464a6e67e7b74a5690d
worker # [  206.949434] pre-start[957]: Copying blob sha256:6b4ad67817bdf22b1dcb46a576b11acaae2fb541c6ba80c2a1fde6ad11b3bb24
worker # [  208.284639] pre-start[957]: Copying blob sha256:4e3b70519ac3ddbc7cbb5e8d1814fc4c1ee8984dc4984ed898ab2ef044a3208a
worker # [  208.511231] pre-start[957]: Copying blob sha256:01633d5563c532d2635fccf7f6c3ca02c3d73ce2cd0eedb3be2cd14b4fea2583
worker # [  218.394657] pre-start[957]: Copying blob sha256:a9a0b4b9599542360748a33a57d8e5ef368c23f2c245e976c6ef715a07424e05
worker # [  218.642702] pre-start[957]: Copying blob sha256:95ce44659bcaa8e3f0fab3939476ac6a8147692c8f2781ba1d465e3b49eb34e4
worker # [  220.461982] pre-start[957]: Copying blob sha256:3a3c09912a23473def409caccce4b5a286499e5d28ed3928e7b98e817c78c270
worker # [  223.767469] pre-start[957]: Copying blob sha256:c16a6884b55b39c22c2d66aa66fa0d8053beb30aa296d7ba0b5e0131000cf3a6
worker # [  248.604665] pre-start[957]: Copying blob sha256:bb4170ea66fb7b5535e636bfcf3969e8c327d78b5b550251f221341a69a51a38
worker # [  253.637985] pre-start[957]: Copying blob sha256:c98acb52cceb324ce0acc8863310de725efb4af8d5610fd1926264cc9b872d37
worker # [  253.640699] pre-start[957]: Copying blob sha256:c461ed905964d0a15f176c62666c89ada6d9d0c816ca6d2cfcb9f12c4e1a1a01
worker # [  253.642936] pre-start[957]: Copying blob sha256:c0ef400d3cd2671531d49135112abcd95f6895238e8f226bd48c5225c6cf5d1f
worker # [  274.343569] pre-start[957]: Copying blob sha256:54d73cb9f6bac56cf05ad0a60ff69a704a91ed518da29eb565f7c9c98eb387b7
worker # [  274.577119] pre-start[957]: Copying blob sha256:b5e9ef7b9c03495be5bfc03c2219ed39846eed862d81506dc41bb78a660a0acd
worker # [  289.045904] pre-start[957]: Copying blob sha256:56107e8adf9d03c347af106a35200ee00d4bd0fdbc69dba64cb70b61e79eaf54
worker # [  289.091466] pre-start[957]: Copying blob sha256:c9658f7dffab4c14ed0ba1215f5851c194a22c5cbc575764ef95746d89ab3065
worker # [  289.094179] pre-start[957]: Copying blob sha256:4f5b058b21556154207043fa88a7ff6c7dd48165543c7b726a3f547de8550632
worker # [  289.692535] pre-start[957]: Copying blob sha256:1da5b3257f6f045d2d1d39c8f9315c030121e8c3758e74cd40a77306b0853d17
worker # [  300.596351] pre-start[957]: Copying blob sha256:b8ccaedb432adbe9884b38f54e973774912ed1d540480ccc52b78eaad908c50a
worker # [  302.402341] pre-start[957]: Copying blob sha256:51d59ab0c8999266fd18b6005a56150cc2abac3ff68a3118f2ebf44a53c7a5ec
worker # [  303.054615] pre-start[957]: Copying blob sha256:6890c11bfe314b4f3bf5a3bd30fc8a80619465358b0bfac44cb28edf7053cac6
worker # [  310.830843] pre-start[957]: Copying blob sha256:a6a96c709be53d645a69753c61ab3bc408f366a0c74edad5da7137225f86747b
worker # [  310.833231] pre-start[957]: Copying blob sha256:d2acc456797fa534eef1f2755ffe5d2d444bb2f64044497528f77ca21c59115e
worker # [  317.491718] pre-start[957]: Copying blob sha256:65a4602176e52aa157f2525a8c1c47d362d11fb9dcb5d980ca97ca4d2148b867
worker # [  318.245430] pre-start[957]: Copying blob sha256:7a73bf0e56d39c4839f8a0c8d572c5b474ed8814311eea900e09df07cb1507de
worker # [  321.338586] pre-start[957]: Copying blob sha256:778227c05d72e059674575f0985c37e7762c21113f8d170141034f54c9239f7d
worker # [  321.696333] pre-start[957]: Copying blob sha256:3294800cb305e833e4d55054e37d646e2de4a1311875ada6a5f32f5b62e3e110
worker # [  321.906527] pre-start[957]: Copying blob sha256:a6c10d3bae0fbeaa320bd656f7cf309b9ecac75997be0d1e56bff33d94c8e2a3
worker # [  321.939432] pre-start[957]: Copying blob sha256:6bd4c8b540f2e6b9acb2eddc0a9614deb766e67f6027f8cf7390e6415b0a0a4f
worker # [  322.240126] pre-start[957]: Copying blob sha256:570be0f8b1547bfd619ceadb4eb8de035c29b010915ab2ae83f99623cd2999e1
worker # [  322.789772] pre-start[957]: Copying blob sha256:9424ae668162882bde68147697173e429cf8b2e8b19266e61deb226c40947aa0
worker # [  323.210619] pre-start[957]: Copying blob sha256:876ba2cba5b7f2cb76eb07a516d910b1f21f3c0919669cd82aeab8fc784e10e3
worker # [  323.833375] pre-start[957]: Copying blob sha256:a75e2f23c60102b34ecc7775fe3d7b60e002f2f69fa35e4b9ac3bb2a0c7f6ba4
worker # [  324.467306] pre-start[957]: Copying blob sha256:ba3de34241649196544f4e4d56cc428436d7fd181b3fb15e51af5e9f28e7cb36
worker # [  325.324548] pre-start[957]: Copying blob sha256:adba5251712f2e97b527782f3bf6f59cc43a69ade795f07739f3272240fc2f3b
worker # [  325.487302] pre-start[957]: Copying blob sha256:f532f52f7e44f7b0636448c24b82dd3c20f9d6c6c9f7e57734ac52280b350e9b
worker # [  325.893220] pre-start[957]: Copying blob sha256:112c80c0894408b729947de2cabc325f3eea36bfe965fadfe0a3b5de86d4f0dd
worker # [  326.023617] pre-start[957]: Copying blob sha256:bf53e972674a0cbd658e1661b53a9d832410da2fbd6abbfca6918bbc75741d32
worker # [  334.493878] pre-start[957]: Copying config sha256:aa8025f634031f7d2dda264578f216b69a52a3083a1ddaa3ab407a3705dfe871
worker # [  334.606723] pre-start[957]: Writing manifest to image destination
worker # [  334.981272] pre-start[957]: Loaded image: localhost/tribuchet-worker:latest
worker # [  334.985428] podman[957]: 2026-08-30 18:09:28.387848842 +0000 UTC m=+240.428881577 image loadfromarchive aa8025f634031f7d2dda264578f216b69a52a3083a1ddaa3ab407a3705dfe871 /nix/store/i9h2as0i9aha31h1j1nm0k31paxs9q36-tribuchet-worker.tar.gz
worker # [  335.003499] systemd[1]: var-lib-containers-storage-overlay.mount: Deactivated successfully.
worker # [  335.280417] podman[1308]: 2026-08-30 18:09:28.61580882 +0000 UTC m=+0.087572863 image pull aa8025f634031f7d2dda264578f216b69a52a3083a1ddaa3ab407a3705dfe871 tribuchet-worker:latest
worker # [  335.348125] podman[1308]: 2026-08-30 18:09:28.754812241 +0000 UTC m=+0.226576284 container create 27b597bbc96a071b244bb87efd54a6a7080924036eeda72385e87fbe38d2bb4a (image=localhost/tribuchet-worker:latest, name=worker, PODMAN_SYSTEMD_UNIT=podman-worker.service)
worker # [  335.379675] systemd[1]: var-lib-containers-storage-overlay-volatile\x2dcheck618047936-merged.mount: Deactivated successfully.
worker # [  335.611103] systemd[1]: Created slice Virtual Machine and Container Slice.
worker # [  335.617423] systemd[1]: Started libcrun container.
worker # [  335.739090] podman[1308]: 2026-08-30 18:09:29.145922843 +0000 UTC m=+0.617686607 container init 27b597bbc96a071b244bb87efd54a6a7080924036eeda72385e87fbe38d2bb4a (image=localhost/tribuchet-worker:latest, name=worker, PODMAN_SYSTEMD_UNIT=podman-worker.service)
worker # [  335.768889] systemd[1]: Started podman-worker.service.
worker # [  335.771838] podman[1308]: 2026-08-30 18:09:29.175394466 +0000 UTC m=+0.647159068 container start 27b597bbc96a071b244bb87efd54a6a7080924036eeda72385e87fbe38d2bb4a (image=localhost/tribuchet-worker:latest, name=worker, PODMAN_SYSTEMD_UNIT=podman-worker.service)
worker: (finished: must succeed: systemctl start podman-worker, in 262.95 seconds)
hub: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered'
worker # [  335.815957] worker[1322]: 2026-08-30T18:09:29.221798Z  INFO tribuchet: worker configuration cfg=WorkerConfig { hub: "https://hub:7437", auth: Mtls, state_dir: "/var/lib/tribuchet/worker", systems: [], ca_cert: "/etc/tribuchet/tls/ca.crt", cert: "/etc/tribuchet/tls/worker.crt", key: "/etc/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: 2, import_jobs: 4, chunk_store_bytes: 10737418240, emulate: {}, fod_network: NetPolicy { default: Allow, rules: [] }, recursive_nix: false, agent_sockets: [], spawn_agents: 2, agent_uid_base: Some(1325400064) }
worker # 
worker # [  335.866908] worker[1322]: 2026-08-30T18:09:29.241238Z  INFO tribuchet::worker::agent_spawn: spawned build agents count=2 uid_isolation=true
worker # 
worker # [  335.879894] podman-worker-start[1308]: 27b597bbc96a071b244bb87efd54a6a7080924036eeda72385e87fbe38d2bb4a
worker # [  335.885539] worker[1322]: 2026-08-30T18:09:29.246435Z  INFO tribuchet::worker: resolved sandbox defaults fod_isolation=false bin_sh=Some("/nix/store/n43nd2kfhbx4w8as8krj1hgj0k6rndh3-busybox-1.37.0/bin/busybox")
worker # 
worker # [  335.890861] worker[1322]: 2026-08-30T18:09:29.256688Z  INFO tribuchet::worker::agent::cgroup: no delegated cgroup; builds run without one
worker # 
worker # [  335.896431] worker[1322]: 2026-08-30T18:09:29.259055Z  INFO tribuchet::worker::agent::cgroup: no delegated cgroup; builds run without one
worker # 
worker # [  335.899883] worker[1322]: 2026-08-30T18:09:29.263044Z  INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325531136 uid_count=65536
worker # 
worker # [  335.905541] worker[1322]: 2026-08-30T18:09:29.263288Z  INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325465600 uid_count=65536
worker # 
worker # [  335.909908] worker[1322]: 2026-08-30T18:09:29.263558Z  INFO tribuchet::worker::agent: agent listening uid=1325400064
worker # 
worker # [  335.913281] worker[1322]: 2026-08-30T18:09:29.264014Z  INFO tribuchet::worker::agent: agent listening uid=1325400065
worker # 
worker # [  335.990114] worker[1322]: 2026-08-30T18:09:29.397079Z  INFO tribuchet::worker::session: connected to hub hub="https://hub:7437" systems=["x86_64-linux"]
worker # 
hub # [  336.974973] tribuchet[908]: 2026-08-30T18:09:28.496274Z  INFO tribuchet::hub: worker registered worker="worker" caps=[SystemCaps { system: "x86_64-linux", features: ["nixos-test", "benchmark", "big-parallel"] }]
hub: (finished: waiting for success: journalctl -u tribuchet-hub | grep -q 'worker registered', in 1.48 seconds)
(finished: subtest: containerized worker registers at the hub, in 264.67 seconds)
subtest: agents run under their own uids
worker: waiting for success: journalctl -u podman-worker | grep 'spawned build agents' | grep -q 'uid_isolation=true'
worker: (finished: waiting for success: journalctl -u podman-worker | grep 'spawned build agents' | grep -q 'uid_isolation=true', in 0.21 seconds)
(finished: subtest: agents run under their own uids, in 0.21 seconds)
subtest: single-uid build
hub: must succeed: nix-build /etc/tt/singleuid.nix --no-out-link
hub # this derivation will be built:
hub #   /nix/store/dxzlzav830szfc45pcj2ackqbv57jkl9-tt-single-uid.drv
hub # building '/nix/store/dxzlzav830szfc45pcj2ackqbv57jkl9-tt-single-uid.drv'...
hub # [  339.396940] tribuchet[908]: 2026-08-30T18:09:30.930733Z  INFO tribuchet::hub::submit: queueing build id="4e657897c994f44376c6362a3d9bcf5d" system="x86_64-linux"
hub # [  339.402967] tribuchet[908]: 2026-08-30T18:09:30.936897Z  INFO tribuchet::hub: dispatching build id="4e657897c994f44376c6362a3d9bcf5d" worker="worker"
hub # tribuchet: building on worker
worker # [  338.424738] worker[1322]: 2026-08-30T18:09:31.830848Z  INFO tribuchet::worker::session: build assigned id="4e657897c994f44376c6362a3d9bcf5d"
worker # 
worker # [  338.430582] worker[1322]: accepted connection from pid 2, user root (trusted)
worker # 
worker # [  338.435130] worker[1322]: warning: the group 'nixbld' specified in 'build-users-group' does not exist
worker # 
hub # [  339.430519] tribuchet[908]: 2026-08-30T18:09:30.964597Z  INFO tribuchet::hub::relay::staging: input path negotiation done id="4e657897c994f44376c6362a3d9bcf5d" total=7 missing=7
hub # [  339.466401] systemd[1]: Started Nix Daemon.
hub # [  339.645483] nix-daemon[938]: accepted connection from pid 908, user root (trusted)
hub # [  339.655210] nix-daemon[938]: accepted connection from pid 908, user root (trusted)
worker # [  338.846700] worker[1322]: accepted connection from pid 2, user root (trusted)
worker # 
worker # [  338.852073] worker[1322]: warning: the group 'nixbld' specified in 'build-users-group' does not exist
worker # 
worker # [  339.072974] worker[1322]: accepted connection from pid 2, user root (trusted)
worker # 
worker # [  339.080781] worker[1322]: warning: the group 'nixbld' specified in 'build-users-group' does not exist
worker # 
worker # [  339.087772] worker[1322]: accepted connection from pid 2, user root (trusted)
worker # 
worker # [  339.091935] worker[1322]: warning: the group 'nixbld' specified in 'build-users-group' does not exist
worker # 
worker # [  342.216209] worker[1322]: accepted connection from pid 2, user root (trusted)
worker # 
worker # [  342.220261] worker[1322]: warning: the group 'nixbld' specified in 'build-users-group' does not exist
worker # 
worker # [  346.917513] worker[1322]: 2026-08-30T18:09:40.324231Z  INFO tribuchet::worker::build::agent_exec: sandbox network decision id="4e657897c994f44376c6362a3d9bcf5d" fixed_output=false network=false net_isolation=false
worker # 
worker # [  346.929677] worker[1322]: 2026-08-30T18:09:40.336448Z  INFO tribuchet::worker::agent: builder started id="4e657897c994f44376c6362a3d9bcf5d" pid=26
worker # 
worker # [  346.933738] worker[1322]: 2026-08-30T18:09:40.336642Z  INFO tribuchet::worker::build::agent_exec: builder started on agent id="4e657897c994f44376c6362a3d9bcf5d" pid=26 agent=/var/lib/tribuchet/worker/agents/2/agent.sock scratch=/var/lib/tribuchet/worker/agents/2/scratch/4e37d17a8f971d86/build
worker # 
worker # [  346.957971] worker[1322]: 2026-08-30T18:09:40.365058Z  INFO tribuchet::worker::agent: builder exited code=0
worker # 
worker # [  347.130277] worker[1322]: 2026-08-30T18:09:40.537109Z  INFO tribuchet::worker::build::agent_exec: builder finished id="4e657897c994f44376c6362a3d9bcf5d" exit_code=0 aborted=None
worker # 
worker # [  347.142876] worker[1322]: 2026-08-30T18:09:40.549457Z  INFO tribuchet::worker::agent: cleanup done id="4e657897c994f44376c6362a3d9bcf5d"
worker # 
worker # [  347.147214] worker[1322]: 2026-08-30T18:09:40.553854Z  INFO tribuchet::worker::agent_spawn: agent exited socket=/var/lib/tribuchet/worker/agents/2/agent.sock status=exit status: 0
worker # 
worker # [  347.153977] worker[1322]: 2026-08-30T18:09:40.560869Z  INFO tribuchet::worker::agent::cgroup: no delegated cgroup; builds run without one
worker # 
worker # [  347.158290] worker[1322]: 2026-08-30T18:09:40.565159Z  INFO tribuchet::worker::agent::platform: agent user namespace mapped uid_base=1325531136 uid_count=65536
worker # 
worker # [  347.162992] worker[1322]: 2026-08-30T18:09:40.565513Z  INFO tribuchet::worker::agent: agent listening uid=1325400065
worker # 
worker # [  347.240614] worker[1322]: 2026-08-30T18:09:40.647453Z  INFO tribuchet::worker::resume::delivery: build result sent, awaiting chunk request id="4e657897c994f44376c6362a3d9bcf5d"
worker # 
worker # [  347.266583] worker[1322]: 2026-08-30T18:09:40.673516Z  INFO tribuchet::worker::resume::delivery: build result acknowledged id="4e657897c994f44376c6362a3d9bcf5d"
worker # 
hub: (finished: must succeed: nix-build /etc/tt/singleuid.nix --no-out-link, in 9.80 seconds)
(finished: subtest: single-uid build, in 9.80 seconds)
(finished: run the VM test script, in 358.14 seconds)
test script finished in 359.85s
cleanup
kill QemuMachine (pid 48)
hub # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)
kill QemuMachine (pid 47)
worker # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)
(finished: cleanup, in 0.79 seconds)