tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script start all VMs machine: starting vm sshClient: starting vm sshClient # Disk image does not exist, creating the virtualisation disk image... sshClient # Formatting '/build/vm-state-sshClient/tmp.IvVj0su5O8', fmt=raw size=1073741824 sshClient: QEMU running (pid 48) sshClient # mke2fs 1.47.4 (6-Mar-2025) sshClient # Discarding device blocks: 0/262144 done sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes sshClient # Filesystem UUID: 36a59b13-2ab8-4bc2-90cf-54d866800dc5 sshClient # Superblock backups stored on blocks: sshClient # 32768, 98304, 163840, 229376 sshClient # sshClient # Allocating group tables: 0/8 done sshClient # Writing inode tables: 0/8 done sshClient # Creating journal (8192 blocks): done sshClient # Writing superblocks and filesystem accounting information: 0/8 done sshClient # sshClient # Virtualisation disk image created. sshClient # Starting virtiofs daemons... sshClient # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-09-22T03:03:11Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-09-22T03:03:11Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-09-22T03:03:11Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-09-22T03:03:11Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-09-22T03:03:11Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-09-22T03:03:11Z INFO virtiofsd] Client connected, servicing requests machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.tqpzlnscbo', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: a9a6c362-25ac-4507-a72c-0735d5798d45 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine: QEMU running (pid 47) machine # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T03:03:11Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-22T03:03:11Z INFO virtiofsd] Waiting for vhost-user socket connection... (finished: start all VMs, in 0.25 seconds) machine # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) subtest: create systemd-homed user on first boot prompt machine # [2026-09-22T03:03:11Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine: waiting for unit systemd-homed.service machine # [2026-09-22T03:03:11Z INFO virtiofsd] Waiting for vhost-user socket connection... machine: waiting for the VM to finish booting machine # [2026-09-22T03:03:11Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-22T03:03:11Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-22T03:03:11Z INFO virtiofsd] Client connected, servicing requests sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) sshClient # sshClient # sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)... sshClient # sshClient # sshClient # sshClient # sshClient # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 sshClient # Press Ctrl-B to configure iPXE (PCI 00:05.0)... sshClient # sshClient # machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # machine # Booting from ROM... sshClient # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 14 11:36:19 UTC 2026 machine # [ 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/8vhz6bkdb6yhgy27a8zd3p84wrl5f3a7-nixos-system-machine-test/init regInfo=/nix/.ro-store/jdwbf2mm3za7jhswf14g00551gvbw37x-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000000] kvm-clock: using sched offset of 473379012 cycles sshClient # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 14 11:36:19 UTC 2026 machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000004] tsc: Detected 2400.012 MHz processor machine # [ 0.000812] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000843] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000845] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT sshClient # [ 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/qjzdwfqrb6c8ax0h3m4nfhakm0v6hx2d-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/j88xypsfwmdzqvikp2grxqzxm4kpwjbh-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.002762] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002773] Using GB pages for direct mapping sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.002825] RAMDISK: [mem 0x3e41f000-0x3ffcffff] sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.002834] ACPI: Early table checksum verification disabled sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.002836] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.002840] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.002844] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.002852] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.002855] ACPI: FACS 0x000000003FFE0000 000040 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.002856] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.002858] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved sshClient # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.002859] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] APIC: Static calls initialized sshClient # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.002861] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.002862] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] sshClient # [ 0.000000] DMI: Memory slots populated: 1/1 sshClient # [ 0.000000] Hypervisor detected: KVM machine # [ 0.002863] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.002864] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.002864] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] sshClient # [ 0.000000] kvm-clock: using sched offset of 512612616 cycles machine # [ 0.002865] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.002865] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] sshClient # [ 0.000005] tsc: Detected 2400.012 MHz processor machine # [ 0.002866] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] sshClient # [ 0.000814] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.003088] No NUMA configuration found sshClient # [ 0.000842] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.003089] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] sshClient # [ 0.000844] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.003091] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005399] Zone ranges: sshClient # [ 0.002743] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.005399] DMA [mem 0x0000000000001000-0x0000000000ffffff] sshClient # [ 0.002754] Using GB pages for direct mapping sshClient # [ 0.002818] RAMDISK: [mem 0x3e41c000-0x3ffcffff] machine # [ 0.005401] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005402] Normal empty sshClient # [ 0.002826] ACPI: Early table checksum verification disabled machine # [ 0.005402] Device empty machine # [ 0.005403] Movable zone start for each node sshClient # [ 0.002829] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.005403] Early memory node ranges sshClient # [ 0.002833] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.005404] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005405] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] sshClient # [ 0.002836] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.005406] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] sshClient # [ 0.002844] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.005424] On node 0, zone DMA: 1 pages in unavailable ranges sshClient # [ 0.002846] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.005669] On node 0, zone DMA: 97 pages in unavailable ranges sshClient # [ 0.002848] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.022844] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.023292] ACPI: PM-Timer IO Port: 0x608 sshClient # [ 0.002849] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.023302] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) sshClient # [ 0.002851] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.023334] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.023336] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) sshClient # [ 0.002852] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.023337] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) sshClient # [ 0.002854] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.023338] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) sshClient # [ 0.002855] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.023339] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) sshClient # [ 0.002855] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.023340] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) sshClient # [ 0.002856] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.023342] ACPI: Using ACPI (MADT) for SMP configuration information sshClient # [ 0.002856] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.023343] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.023347] TSC deadline timer available sshClient # [ 0.002857] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.023350] CPU topo: Max. logical packages: 1 sshClient # [ 0.002857] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.023351] CPU topo: Max. logical dies: 1 sshClient # [ 0.003089] No NUMA configuration found machine # [ 0.023351] CPU topo: Max. dies per package: 1 sshClient # [ 0.003090] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.023355] CPU topo: Max. threads per core: 1 machine # [ 0.023355] CPU topo: Num. cores per package: 1 sshClient # [ 0.003092] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] sshClient # [ 0.005873] Zone ranges: machine # [ 0.023356] CPU topo: Num. threads per package: 1 sshClient # [ 0.005874] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.023356] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs sshClient # [ 0.005875] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] sshClient # [ 0.005877] Normal empty machine # [ 0.023371] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() sshClient # [ 0.005877] Device empty sshClient # [ 0.005878] Movable zone start for each node machine # [ 0.023399] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] sshClient # [ 0.005879] Early memory node ranges machine # [ 0.023401] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] sshClient # [ 0.005879] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.023402] [mem 0x40000000-0xafffffff] available for PCI devices sshClient # [ 0.005880] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.023403] Booting paravirtualized kernel on KVM sshClient # [ 0.005881] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] sshClient # [ 0.005901] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.023405] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns sshClient # [ 0.006176] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.027902] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 sshClient # [ 0.024769] On node 0, zone DMA32: 40 pages in unavailable ranges sshClient # [ 0.025229] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.030669] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 sshClient # [ 0.025240] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.030714] kvm-guest: PV spinlocks disabled, single CPU sshClient # [ 0.025274] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 sshClient # [ 0.025277] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) sshClient # [ 0.025278] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) sshClient # [ 0.025279] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) sshClient # [ 0.025280] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.030715] 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/8vhz6bkdb6yhgy27a8zd3p84wrl5f3a7-nixos-system-machine-test/init regInfo=/nix/.ro-store/jdwbf2mm3za7jhswf14g00551gvbw37x-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.025281] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) sshClient # [ 0.025283] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.030803] Unknown kernel command line parameters "regInfo=/nix/.ro-store/jdwbf2mm3za7jhswf14g00551gvbw37x-closure-info/registration", will be passed to user space. sshClient # [ 0.025284] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.030816] random: crng init done sshClient # [ 0.025288] TSC deadline timer available sshClient # [ 0.025291] CPU topo: Max. logical packages: 1 machine # [ 0.030816] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes sshClient # [ 0.025292] CPU topo: Max. logical dies: 1 machine # [ 0.030837] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) sshClient # [ 0.025293] CPU topo: Max. dies per package: 1 sshClient # [ 0.025296] CPU topo: Max. threads per core: 1 machine # [ 0.030850] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) sshClient # [ 0.025296] CPU topo: Num. cores per package: 1 machine # [ 0.030884] Fallback order for Node 0: 0 sshClient # [ 0.025297] CPU topo: Num. threads per package: 1 machine # [ 0.030887] Built 1 zonelists, mobility grouping on. Total pages: 262006 sshClient # [ 0.025297] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.030888] Policy zone: DMA32 sshClient # [ 0.025315] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.033665] mem auto-init: stack:all(zero), heap alloc:on, heap free:off sshClient # [ 0.025345] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.035988] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.038868] allocated 2097152 bytes of page_ext sshClient # [ 0.025347] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.048628] ftrace: allocating 48787 entries in 192 pages sshClient # [ 0.025348] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.048630] ftrace: allocated 192 pages with 2 groups sshClient # [ 0.025349] Booting paravirtualized kernel on KVM machine # [ 0.049518] Dynamic Preempt: lazy machine # [ 0.049720] rcu: Preemptible hierarchical RCU implementation. sshClient # [ 0.025352] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.049721] rcu: RCU event tracing is enabled. sshClient # [ 0.029873] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.049722] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. sshClient # [ 0.032006] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.049723] Trampoline variant of Tasks RCU enabled. sshClient # [ 0.032051] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.049724] Rude variant of Tasks RCU enabled. machine # [ 0.049724] Tracing variant of Tasks RCU enabled. machine # [ 0.049724] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.049725] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.049741] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.032053] 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/qjzdwfqrb6c8ax0h3m4nfhakm0v6hx2d-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/j88xypsfwmdzqvikp2grxqzxm4kpwjbh-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.049742] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.032145] Unknown kernel command line parameters "regInfo=/nix/.ro-store/j88xypsfwmdzqvikp2grxqzxm4kpwjbh-closure-info/registration", will be passed to user space. machine # [ 0.049743] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.032157] random: crng init done machine # [ 0.054277] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 sshClient # [ 0.032158] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.054577] rcu: srcu_init: Setting srcu_struct sizes based on contention. sshClient # [ 0.032179] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) sshClient # [ 0.032191] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.054582] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns sshClient # [ 0.032222] Fallback order for Node 0: 0 sshClient # [ 0.032225] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.054682] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) sshClient # [ 0.032226] Policy zone: DMA32 machine # [ 0.058174] Console: colour VGA+ 80x25 machine # [ 0.058177] printk: legacy console [tty0] enabled sshClient # [ 0.034701] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.087801] printk: legacy console [ttyS0] enabled sshClient # [ 0.037120] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.190204] ACPI: Core revision 20250807 sshClient # [ 0.039505] allocated 2097152 bytes of page_ext sshClient # [ 0.049397] ftrace: allocating 48787 entries in 192 pages sshClient # [ 0.049398] ftrace: allocated 192 pages with 2 groups sshClient # [ 0.050239] Dynamic Preempt: lazy machine # [ 0.191089] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.050418] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.192713] APIC: Switch to symmetric I/O mode setup sshClient # [ 0.050419] rcu: RCU event tracing is enabled. machine # [ 0.193720] x2apic enabled sshClient # [ 0.050420] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. sshClient # [ 0.050421] Trampoline variant of Tasks RCU enabled. machine # [ 0.194479] APIC: Switched APIC routing to: physical x2apic sshClient # [ 0.050421] Rude variant of Tasks RCU enabled. sshClient # [ 0.050422] Tracing variant of Tasks RCU enabled. sshClient # [ 0.050422] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.196276] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 sshClient # [ 0.050423] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 sshClient # [ 0.050438] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.197282] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns sshClient # [ 0.050440] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.199008] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) sshClient # [ 0.050440] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.200091] x86/cpu: User Mode Instruction Prevention (UMIP) activated sshClient # [ 0.054812] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.202007] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 sshClient # [ 0.055094] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.202952] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 sshClient # [ 0.055101] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns sshClient # [ 0.055207] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.203791] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto sshClient # [ 0.058736] Console: colour VGA+ 80x25 sshClient # [ 0.058739] printk: legacy console [tty0] enabled sshClient # [ 0.088184] printk: legacy console [ttyS0] enabled machine # [ 0.205005] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl sshClient # [ 0.186588] ACPI: Core revision 20250807 machine # [ 0.207005] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.208004] Spectre V2 : Mitigation: Enhanced / Automatic IBRS sshClient # [ 0.187448] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.188960] APIC: Switch to symmetric I/O mode setup machine # [ 0.209005] Speculative Return Stack Overflow: Mitigation: Safe RET sshClient # [ 0.189906] x2apic enabled sshClient # [ 0.190651] APIC: Switched APIC routing to: physical x2apic sshClient # [ 0.192444] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.210004] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.212011] Spectre V2 : Enabling IBPB for BPF sshClient # [ 0.193412] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.212749] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier sshClient # [ 0.195041] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.214005] active return thunk: srso_alias_return_thunk sshClient # [ 0.196128] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.215026] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' sshClient # [ 0.197174] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.216005] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.198038] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.217005] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' sshClient # [ 0.199042] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.218784] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.219766] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' sshClient # [ 0.201038] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.220782] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' sshClient # [ 0.202038] Transient Scheduler Attacks: Vulnerable: No microcode sshClient # [ 0.203038] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.221816] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' sshClient # [ 0.204038] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.223005] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.224005] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.225004] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.226004] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 sshClient # [ 0.205038] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.227005] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 sshClient # [ 0.207045] Spectre V2 : Enabling IBPB for BPF machine # [ 0.228004] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. sshClient # [ 0.208038] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier sshClient # [ 0.209039] active return thunk: srso_alias_return_thunk sshClient # [ 0.210059] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' sshClient # [ 0.211038] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.212038] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' sshClient # [ 0.213038] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' sshClient # [ 0.214038] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' sshClient # [ 0.215038] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' sshClient # [ 0.216038] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' sshClient # [ 0.217038] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 sshClient # [ 0.218773] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 sshClient # [ 0.219038] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 sshClient # [ 0.220038] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 sshClient # [ 0.221038] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 sshClient # [ 0.222038] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.262669] Freeing SMP alternatives memory: 44K machine # [ 0.263007] pid_max: default: 32768 minimum: 301 machine # [ 0.264091] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.265099] landlock: Up and running. machine # [ 0.266005] Yama: becoming mindful. machine # [ 0.267052] LSM support for eBPF active machine # [ 0.267810] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.269025] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.271472] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.272614] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.273014] ... version: 2 machine # [ 0.273772] ... bit width: 48 machine # [ 0.274011] ... generic counters: 6 machine # [ 0.274784] ... generic bitmap: 000000000000003f sshClient # [ 0.256689] Freeing SMP alternatives memory: 44K machine # [ 0.275008] ... fixed-purpose counters: 0 sshClient # [ 0.257042] pid_max: default: 32768 minimum: 301 machine # [ 0.275739] ... fixed-purpose bitmap: 0000000000000000 sshClient # [ 0.258142] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.276007] ... value mask: 0000ffffffffffff sshClient # [ 0.259155] landlock: Up and running. machine # [ 0.276970] ... max period: 00007fffffffffff sshClient # [ 0.260038] Yama: becoming mindful. machine # [ 0.277731] ... global_ctrl mask: 000000000000003f sshClient # [ 0.260850] LSM support for eBPF active machine # [ 0.278116] signal: max sigframe size: 3376 sshClient # [ 0.261618] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.279045] rcu: Hierarchical SRCU implementation. machine # [ 0.279859] rcu: Max phase no-delay instances is 400. sshClient # [ 0.262945] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.265201] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) sshClient # [ 0.266643] Performance Events: Fam17h+ core perfctr, AMD PMU driver. sshClient # [ 0.267057] ... version: 2 machine # [ 0.285182] smp: Bringing up secondary CPUs ... sshClient # [ 0.267771] ... bit width: 48 machine # [ 0.285921] smp: Brought up 1 node, 1 CPU sshClient # [ 0.268041] ... generic counters: 6 machine # [ 0.286534] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) sshClient # [ 0.268741] ... generic bitmap: 000000000000003f sshClient # [ 0.269040] ... fixed-purpose counters: 0 sshClient # [ 0.269738] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.287176] Memory: 941780K/1048024K available (17247K kernel code, 2727K rwdata, 13616K rodata, 3652K init, 2976K bss, 98880K reserved, 0K cma-reserved) sshClient # [ 0.270040] ... value mask: 0000ffffffffffff machine # [ 0.288210] devtmpfs: initialized sshClient # [ 0.270896] ... max period: 00007fffffffffff machine # [ 0.288957] x86/mm: Memory block size: 128MB sshClient # [ 0.271702] ... global_ctrl mask: 000000000000003f sshClient # [ 0.272140] signal: max sigframe size: 3376 sshClient # [ 0.272920] rcu: Hierarchical SRCU implementation. machine # [ 0.290596] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.273630] rcu: Max phase no-delay instances is 400. machine # [ 0.291032] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.292084] pinctrl core: initialized pinctrl subsystem machine # [ 0.293259] PM: RTC time: 03:03:11, date: 2026-09-22 sshClient # [ 0.278712] smp: Bringing up secondary CPUs ... sshClient # [ 0.279054] smp: Brought up 1 node, 1 CPU machine # [ 0.296873] NET: Registered PF_NETLINK/PF_ROUTE protocol family sshClient # [ 0.279742] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.298156] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations sshClient # [ 0.280221] Memory: 941756K/1048024K available (17247K kernel code, 2727K rwdata, 13616K rodata, 3652K init, 2976K bss, 98892K reserved, 0K cma-reserved) machine # [ 0.299022] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations sshClient # [ 0.281289] devtmpfs: initialized machine # [ 0.300168] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations sshClient # [ 0.282111] x86/mm: Memory block size: 128MB machine # [ 0.301018] audit: initializing netlink subsys (disabled) machine # [ 0.302206] thermal_sys: Registered thermal governor 'fair_share' sshClient # [ 0.283790] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.302208] thermal_sys: Registered thermal governor 'bang_bang' sshClient # [ 0.284927] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.303009] thermal_sys: Registered thermal governor 'step_wise' sshClient # [ 0.286115] pinctrl core: initialized pinctrl subsystem machine # [ 0.303982] thermal_sys: Registered thermal governor 'user_space' sshClient # [ 0.287232] PM: RTC time: 03:03:11, date: 2026-09-22 machine # [ 0.304793] audit: type=2000 audit(1790046192.366:1): state=initialized audit_enabled=0 res=1 machine # [ 0.307010] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.307025] cpuidle: using governor menu sshClient # [ 0.290765] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.309319] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 sshClient # [ 0.291403] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations sshClient # [ 0.292060] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.310753] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.312009] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry sshClient # [ 0.293185] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.313019] PCI: Using configuration type 1 for base access sshClient # [ 0.294050] audit: initializing netlink subsys (disabled) sshClient # [ 0.295163] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.314127] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. sshClient # [ 0.295165] thermal_sys: Registered thermal governor 'bang_bang' sshClient # [ 0.296041] thermal_sys: Registered thermal governor 'step_wise' sshClient # [ 0.296964] thermal_sys: Registered thermal governor 'user_space' sshClient # [ 0.297774] audit: type=2000 audit(1790046192.383:1): state=initialized audit_enabled=0 res=1 sshClient # [ 0.299043] thermal_sys: Registered thermal governor 'power_allocator' sshClient # [ 0.299058] cpuidle: using governor menu machine # [ 0.320033] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.321008] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page sshClient # [ 0.301286] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 sshClient # [ 0.302307] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] sshClient # [ 0.303043] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.324008] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages sshClient # [ 0.304052] PCI: Using configuration type 1 for base access machine # [ 0.325007] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page sshClient # [ 0.305133] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. sshClient # [ 0.310285] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages sshClient # [ 0.311042] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.335465] ACPI: Added _OSI(Module Device) machine # [ 0.336009] ACPI: Added _OSI(Processor Device) machine # [ 0.336773] ACPI: Added _OSI(Processor Aggregator Device) sshClient # [ 0.316042] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages sshClient # [ 0.317040] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.346636] ACPI: 1 ACPI AML tables successfully acquired and loaded sshClient # [ 0.327400] ACPI: Added _OSI(Module Device) machine # [ 0.348014] ACPI: Interpreter enabled machine # [ 0.348646] ACPI: PM: (supports S0 S3 S4 S5) sshClient # [ 0.328043] ACPI: Added _OSI(Processor Device) machine # [ 0.349008] ACPI: Using IOAPIC for interrupt routing sshClient # [ 0.328836] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.349895] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.355008] PCI: Using E820 reservations for host bridge windows machine # [ 0.356107] ACPI: Enabled 2 GPEs in block 00 to 3F sshClient # [ 0.338070] ACPI: 1 ACPI AML tables successfully acquired and loaded sshClient # [ 0.342007] ACPI: Interpreter enabled sshClient # [ 0.342597] ACPI: PM: (supports S0 S3 S4 S5) sshClient # [ 0.343042] ACPI: Using IOAPIC for interrupt routing machine # [ 0.364804] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) sshClient # [ 0.343971] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.366836] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.368088] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.369129] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] sshClient # [ 0.349041] PCI: Using E820 reservations for host bridge windows machine # [ 0.370368] PCI host bridge to bus 0000:00 sshClient # [ 0.350178] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.371011] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.372008] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.373007] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.374007] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.375007] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.376007] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.377008] pci_bus 0000:00: root bus resource [bus 00-ff] sshClient # [ 0.358328] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.377997] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint sshClient # [ 0.359048] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.379411] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint sshClient # [ 0.360118] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] sshClient # [ 0.361163] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] sshClient # [ 0.362408] PCI host bridge to bus 0000:00 sshClient # [ 0.363045] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] sshClient # [ 0.364041] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] sshClient # [ 0.365040] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] sshClient # [ 0.366041] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.382073] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.383020] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] sshClient # [ 0.367051] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.383963] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] sshClient # [ 0.368042] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.369073] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.385106] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] sshClient # [ 0.370119] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.386727] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.371496] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.389100] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.390015] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.390963] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.391822] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.393301] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.374178] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.395027] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] sshClient # [ 0.375056] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.395870] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.396743] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] sshClient # [ 0.376047] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] sshClient # [ 0.377211] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.398429] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint sshClient # [ 0.378802] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.401026] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] sshClient # [ 0.381074] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.402014] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] sshClient # [ 0.381937] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.402930] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] sshClient # [ 0.382826] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.404395] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.383969] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] sshClient # [ 0.385636] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.406018] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.406883] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.407737] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] sshClient # [ 0.387075] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.408013] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] sshClient # [ 0.387942] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] sshClient # [ 0.388841] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.409589] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint sshClient # [ 0.390506] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.410867] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.411730] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.412545] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.393070] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] sshClient # [ 0.394047] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.414027] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] sshClient # [ 0.395062] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.414967] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] sshClient # [ 0.396625] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.416591] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.417824] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] sshClient # [ 0.398077] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.418720] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] sshClient # [ 0.398984] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.419550] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.399814] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] sshClient # [ 0.401046] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.421020] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.421938] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] sshClient # [ 0.402615] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.423340] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint sshClient # [ 0.403961] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] sshClient # [ 0.404808] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.425015] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.425829] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] sshClient # [ 0.405607] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.426722] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.427550] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.407053] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] sshClient # [ 0.408062] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.429015] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] sshClient # [ 0.409636] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.429849] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.430984] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] sshClient # [ 0.410863] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] sshClient # [ 0.411820] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.432384] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.433532] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] sshClient # [ 0.413507] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.434258] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.415079] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.435528] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] sshClient # [ 0.416063] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.436223] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.417590] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.437515] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] sshClient # [ 0.419092] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] sshClient # [ 0.420047] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] sshClient # [ 0.421062] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] sshClient # [ 0.422572] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.424048] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] sshClient # [ 0.424946] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] sshClient # [ 0.425814] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] sshClient # [ 0.427553] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.438224] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint sshClient # [ 0.428644] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.441457] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] sshClient # [ 0.429257] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.442287] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint sshClient # [ 0.431112] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.443292] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO sshClient # [ 0.432204] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.444261] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint sshClient # [ 0.433621] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.446817] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.447636] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.448350] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.449598] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.452958] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.453824] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.454819] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.455813] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 sshClient # [ 0.434257] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.456882] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 sshClient # [ 0.436582] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.457910] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.458845] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 sshClient # [ 0.437334] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.459813] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.460755] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 sshClient # [ 0.438408] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.461020] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.439301] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.461958] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.462730] ACPI: PCI: Interrupt link GSID configured for IRQ 19 sshClient # [ 0.441001] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.463022] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 sshClient # [ 0.441698] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.463950] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.464714] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 sshClient # [ 0.442355] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.465020] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.443627] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.467019] iommu: Default domain type: Translated machine # [ 0.467784] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.468274] ACPI: bus type USB registered machine # [ 0.469011] usbcore: registered new interface driver usbfs machine # [ 0.469878] usbcore: registered new interface driver hub sshClient # [ 0.447519] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.470669] usbcore: registered new device driver usb sshClient # [ 0.448152] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.471885] NetLabel: Initializing sshClient # [ 0.449142] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.472420] NetLabel: domain hash size = 128 sshClient # [ 0.450141] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.473007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO sshClient # [ 0.451138] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.473990] NetLabel: unlabeled traffic allowed by default machine # [ 0.474677] PCI: Using ACPI for IRQ routing sshClient # [ 0.452138] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 sshClient # [ 0.453229] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 sshClient # [ 0.454145] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 sshClient # [ 0.455078] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 sshClient # [ 0.456054] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.457052] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 sshClient # [ 0.458078] ACPI: PCI: Interrupt link GSID configured for IRQ 19 sshClient # [ 0.459053] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 sshClient # [ 0.460052] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 sshClient # [ 0.461053] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 sshClient # [ 0.462059] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.464231] iommu: Default domain type: Translated sshClient # [ 0.465053] iommu: DMA domain TLB invalidation policy: lazy mode sshClient # [ 0.466306] ACPI: bus type USB registered sshClient # [ 0.467099] usbcore: registered new interface driver usbfs sshClient # [ 0.468057] usbcore: registered new interface driver hub sshClient # [ 0.468990] usbcore: registered new device driver usb sshClient # [ 0.470623] NetLabel: Initializing sshClient # [ 0.471057] NetLabel: domain hash size = 128 sshClient # [ 0.471825] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO sshClient # [ 0.472238] NetLabel: unlabeled traffic allowed by default sshClient # [ 0.473053] PCI: Using ACPI for IRQ routing machine # [ 0.518159] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.519003] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.519003] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.519012] vgaarb: loaded machine # [ 0.519732] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.520009] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.524098] clocksource: Switched to clocksource kvm-clock machine # [ 0.527524] VFS: Disk quotas dquot_6.6.0 machine # [ 0.528186] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.529515] pnp: PnP ACPI init machine # [ 0.530246] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.531177] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.532660] pnp: PnP ACPI: found 5 devices sshClient # [ 0.516919] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.540147] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns sshClient # [ 0.517037] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.541516] clocksource: Switched to clocksource acpi_pm machine # [ 0.542407] NET: Registered PF_INET protocol family sshClient # [ 0.517037] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none sshClient # [ 0.517045] vgaarb: loaded machine # [ 0.543369] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) sshClient # [ 0.517768] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 sshClient # [ 0.518041] hpet0: 3 comparators, 64-bit 100.000000 MHz counter sshClient # [ 0.523133] clocksource: Switched to clocksource kvm-clock sshClient # [ 0.524902] VFS: Disk quotas dquot_6.6.0 sshClient # [ 0.527488] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) sshClient # [ 0.528901] pnp: PnP ACPI init sshClient # [ 0.529757] ACPI: IRQ 4 override to edge(!), high(!) sshClient # [ 0.530802] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved sshClient # [ 0.532391] pnp: PnP ACPI: found 5 devices machine # [ 0.559893] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.561342] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.562701] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.564044] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.565287] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.566392] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.567675] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.540000] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns sshClient # [ 0.541459] clocksource: Switched to clocksource acpi_pm machine # [ 0.568743] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.542477] NET: Registered PF_INET protocol family machine # [ 0.569954] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.570858] NET: Registered PF_XDP protocol family sshClient # [ 0.543477] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.571700] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.572697] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.573752] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.574901] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.576032] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.577173] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.578968] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.581304] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.583253] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.585216] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.586932] PCI: CLS 0 bytes, default 64 machine # [ 0.587832] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns sshClient # [ 0.561093] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.589645] Trying to unpack rootfs image as initramfs... sshClient # [ 0.562547] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.563910] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.565287] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) sshClient # [ 0.566758] TCP: Hash tables configured (established 8192 bind 8192) sshClient # [ 0.567908] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) sshClient # [ 0.569269] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.570431] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.571685] NET: Registered PF_UNIX/PF_LOCAL protocol family sshClient # [ 0.572701] NET: Registered PF_XDP protocol family sshClient # [ 0.573596] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] sshClient # [ 0.574648] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] sshClient # [ 0.575775] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] sshClient # [ 0.576922] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] sshClient # [ 0.578102] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.579255] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.581128] ACPI: \_SB_.GSIA: Enabled at IRQ 16 sshClient # [ 0.583595] ACPI: \_SB_.GSIB: Enabled at IRQ 17 sshClient # [ 0.585584] ACPI: \_SB_.GSIC: Enabled at IRQ 18 sshClient # [ 0.587597] ACPI: \_SB_.GSID: Enabled at IRQ 19 sshClient # [ 0.589360] PCI: CLS 0 bytes, default 64 sshClient # [ 0.590264] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns sshClient # [ 0.592074] Trying to unpack rootfs image as initramfs... machine # [ 0.633170] Initialise system trusted keyrings machine # [ 0.634144] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.656490] Key type asymmetric registered machine # [ 0.657162] Asymmetric key parser 'x509' registered machine # [ 0.657997] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.661548] io scheduler mq-deadline registered machine # [ 0.662312] io scheduler kyber registered sshClient # [ 0.637385] Initialise system trusted keyrings machine # [ 0.664995] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.666244] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A sshClient # [ 0.640017] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.672038] Linux agpgart interface v0.103 machine # [ 0.672873] ACPI: bus type drm_connector registered machine # [ 0.675864] usbcore: registered new interface driver usbserial_generic machine # [ 0.676982] usbserial: USB Serial support registered for generic machine # [ 0.679465] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.679465] Please enable it if your BIOS has the CPPC option. machine # [ 0.681693] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.685578] drop_monitor: Initializing network drop monitor service machine # [ 0.686777] NET: Registered PF_INET6 protocol family machine # [ 0.689960] Segment Routing with IPv6 sshClient # [ 0.663094] Key type asymmetric registered sshClient # [ 0.663851] Asymmetric key parser 'x509' registered machine # [ 0.692487] In-situ OAM (IOAM) with IPv6 sshClient # [ 0.664775] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.693506] IPI shorthand broadcast: enabled sshClient # [ 0.668125] io scheduler mq-deadline registered sshClient # [ 0.668918] io scheduler kyber registered sshClient # [ 0.673142] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.701865] sched_clock: Marking stable (561064090, 140421718)->(768710016, -67224208) sshClient # [ 0.674418] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.706529] registered taskstats version 1 sshClient # [ 0.679834] Linux agpgart interface v0.103 machine # [ 0.707454] Loading compiled-in X.509 certificates sshClient # [ 0.680625] ACPI: bus type drm_connector registered sshClient # [ 0.685088] usbcore: registered new interface driver usbserial_generic sshClient # [ 0.686167] usbserial: USB Serial support registered for generic sshClient # [ 0.688963] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. sshClient # [ 0.688963] Please enable it if your BIOS has the CPPC option. sshClient # [ 0.691254] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled sshClient # [ 0.695095] drop_monitor: Initializing network drop monitor service sshClient # [ 0.696358] NET: Registered PF_INET6 protocol family machine # [ 0.726450] Demotion targets for Node 0: null sshClient # [ 0.699455] Segment Routing with IPv6 machine # [ 0.727261] Key type .fscrypt registered machine # [ 0.727925] Key type fscrypt-provisioning registered machine # [ 0.728826] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.701980] In-situ OAM (IOAM) with IPv6 sshClient # [ 0.703086] IPI shorthand broadcast: enabled machine # [ 0.731453] ima: Allocated hash algorithm: sha1 machine # [ 0.732208] ima: No architecture policies found machine # [ 0.734452] PM: Magic number: 10:500:58 machine # [ 0.735964] RAS: Correctable Errors collector initialized. sshClient # [ 0.711447] sched_clock: Marking stable (575013992, 135936491)->(785584222, -74633739) machine # [ 0.745134] clk: Disabling unused clocks sshClient # [ 0.718145] registered taskstats version 1 sshClient # [ 0.719186] Loading compiled-in X.509 certificates machine # [ 0.749449] PM: genpd: Disabling unused power domains sshClient # [ 0.735580] Demotion targets for Node 0: null sshClient # [ 0.738009] Key type .fscrypt registered sshClient # [ 0.738718] Key type fscrypt-provisioning registered sshClient # [ 0.739722] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.743975] ima: Allocated hash algorithm: sha1 sshClient # [ 0.744806] ima: No architecture policies found sshClient # [ 0.747970] PM: Magic number: 10:500:58 sshClient # [ 0.749657] RAS: Correctable Errors collector initialized. sshClient # [ 0.757720] clk: Disabling unused clocks sshClient # [ 0.760963] PM: genpd: Disabling unused power domains machine # [ 0.902900] Freeing initrd memory: 28356K machine # [ 0.906150] Freeing unused decrypted memory: 2028K machine # [ 0.908809] Freeing unused kernel image (initmem) memory: 3652K machine # [ 0.909849] Write protecting the kernel read-only data: 32768k machine # [ 0.911669] Freeing unused kernel image (text/rodata gap) memory: 1184K machine # [ 0.913102] Freeing unused kernel image (rodata/data gap) memory: 720K sshClient # [ 0.925250] Freeing initrd memory: 28368K sshClient # [ 0.928463] Freeing unused decrypted memory: 2028K sshClient # [ 0.931266] Freeing unused kernel image (initmem) memory: 3652K sshClient # [ 0.932341] Write protecting the kernel read-only data: 32768k sshClient # [ 0.934244] Freeing unused kernel image (text/rodata gap) memory: 1184K sshClient # [ 0.935804] Freeing unused kernel image (rodata/data gap) memory: 720K machine # [ 0.963899] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.964946] Run /init as init process machine # [ 0.975345] systemd[1]: Inserted module 'autofs4' machine # [ 0.994863] fuse: init (API version 7.45) machine # [ 1.002241] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.004618] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.007332] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.009240] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.013759] virtiofs virtio5: discovered new tag: nix-store sshClient # [ 0.986850] x86/mm: Checked W+X mappings: passed, no W+X pages found. sshClient # [ 0.987919] Run /init as init process machine # [ 1.015350] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.022861] virtiofs virtio6: discovered new tag: shared machine # [ 1.024641] virtiofs virtio6: virtio_fs_setup_dax: No cache capability sshClient # [ 0.998990] systemd[1]: Inserted module 'autofs4' machine # [ 1.028112] virtiofs virtio7: discovered new tag: xchg machine # [ 1.029620] virtiofs virtio7: virtio_fs_setup_dax: No cache capability sshClient # [ 1.018793] fuse: init (API version 7.45) sshClient # [ 1.026234] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.053580] systemd[1]: Successfully made /usr/ read-only. sshClient # [ 1.028890] ACPI: \_SB_.GSIH: Enabled at IRQ 23 sshClient # [ 1.032288] ACPI: \_SB_.GSIE: Enabled at IRQ 20 sshClient # [ 1.034471] ACPI: \_SB_.GSIF: Enabled at IRQ 21 sshClient # [ 1.040216] virtiofs virtio5: discovered new tag: nix-store sshClient # [ 1.041769] virtiofs virtio5: virtio_fs_setup_dax: No cache capability sshClient # [ 1.048614] virtiofs virtio6: discovered new tag: shared sshClient # [ 1.050242] virtiofs virtio6: virtio_fs_setup_dax: No cache capability sshClient # [ 1.053766] virtiofs virtio7: discovered new tag: xchg sshClient # [ 1.055228] virtiofs virtio7: virtio_fs_setup_dax: No cache capability sshClient # [ 1.076699] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.389376] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) machine # [ 1.394569] systemd[1]: Detected virtualization kvm. machine # [ 1.395452] systemd[1]: Detected architecture x86-64. machine # [ 1.396366] systemd[1]: Running in initrd. machine # [ 1.397556] systemd[1]: Initializing machine ID from random generator. machine # [ 1.398810] systemd[1]: Hostname set to . sshClient # [ 1.412315] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) sshClient # [ 1.417081] systemd[1]: Detected virtualization kvm. sshClient # [ 1.417899] systemd[1]: Detected architecture x86-64. sshClient # [ 1.418743] systemd[1]: Running in initrd. sshClient # [ 1.419789] systemd[1]: Initializing machine ID from random generator. sshClient # [ 1.420970] systemd[1]: Hostname set to . machine # [ 1.472392] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.509739] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.514070] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.515257] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.516617] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.517692] systemd[1]: Reached target Path Units. machine # [ 1.518570] systemd[1]: Reached target Slice Units. machine # [ 1.519380] systemd[1]: Reached target Swaps. machine # [ 1.520143] systemd[1]: Reached target Timer Units. machine # [ 1.521107] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 1.494190] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.522292] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.523392] systemd[1]: Listening on Journal Sockets. machine # [ 1.524379] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.525288] systemd[1]: Reached target Socket Units. machine # [ 1.527041] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.531504] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.538511] systemd[1]: Starting Journal Service... sshClient # [ 1.529787] systemd[1]: Queued start job for default target Initrd Default Target. sshClient # [ 1.534186] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.550322] systemd[1]: Starting Load Kernel Modules... sshClient # [ 1.535296] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 1.536675] systemd[1]: Expecting device /dev/disk/by-label/nixos... sshClient # [ 1.537748] systemd[1]: Reached target Path Units. sshClient # [ 1.538596] systemd[1]: Reached target Slice Units. sshClient # [ 1.539451] systemd[1]: Reached target Swaps. sshClient # [ 1.540201] systemd[1]: Reached target Timer Units. machine # [ 1.567896] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 1.541110] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 1.542268] systemd[1]: Listening on Journal Socket (/dev/log). sshClient # [ 1.543351] systemd[1]: Listening on Journal Sockets. sshClient # [ 1.544268] systemd[1]: Listening on udev Kernel Socket. sshClient # [ 1.545158] systemd[1]: Reached target Socket Units. sshClient # [ 1.546834] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.575524] systemd[1]: Starting Coldplug All udev Devices... sshClient # [ 1.551021] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 1.560522] systemd[1]: Starting Journal Service... machine # [ 1.590547] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.595086] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.602858] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.605897] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.608883] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config sshClient # [ 1.571039] systemd[1]: Starting Load Kernel Modules... sshClient # [ 1.586404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 1.591734] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.621513] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.625946] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. sshClient # [ 1.605022] systemd[1]: Finished Create List of Static Device Nodes. sshClient # [ 1.608903] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.637617] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev sshClient # [ 1.616404] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 1.621750] systemd-journald[65]: Collecting audit messages is disabled. sshClient # [ 1.623363] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config sshClient # [ 1.632729] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.663520] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.671628] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 1.644355] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. sshClient # [ 1.652017] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.681957] systemd[1]: Finished Load Kernel Modules. machine # [ 1.690651] systemd[1]: Starting Apply Kernel Variables... sshClient # [ 1.675487] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.709463] systemd[1]: Finished Create Static Device Nodes in /dev. sshClient # [ 1.683153] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.714637] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.720516] systemd[1]: Reached target Local File Systems. sshClient # [ 1.695021] systemd[1]: Finished Load Kernel Modules. machine # [ 1.727629] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.583836] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.589518] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.590576] systemd-modules-load[66]: Inserted module 'virtio_gpu' sshClient # [ 1.704173] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.737716] systemd[1]: Started Journal Service. machine # [ 1.604941] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 1.724020] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.616282] systemd[1]: Starting Create System Files and Directories... sshClient # [ 1.729363] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 1.735050] systemd[1]: Reached target Local File Systems. sshClient # [ 1.741137] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 1.607173] systemd-modules-load[66]: Inserted module 'dm_mod' sshClient # [ 1.609256] systemd-modules-load[66]: Inserted module 'virtio_balloon' sshClient # [ 1.610305] systemd-modules-load[66]: Inserted module 'virtio_gpu' sshClient # [ 1.753193] systemd[1]: Started Journal Service. machine # [ 1.643231] systemd[1]: Finished Create System Files and Directories. sshClient # [ 1.623142] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.650341] systemd-udevd[73]: Using default interface naming scheme 'v261'. sshClient # [ 1.634373] systemd[1]: Starting Create System Files and Directories... machine # [ 1.672811] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 1.660384] systemd[1]: Finished Create System Files and Directories. sshClient # [ 1.667295] systemd-udevd[73]: Using default interface naming scheme 'v261'. sshClient # [ 1.690388] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.726111] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.726932] systemd[1]: Reached target System Initialization. machine # [ 1.727800] systemd[1]: Reached target Basic System. sshClient # [ 1.739741] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 1.743088] systemd[1]: Reached target System Initialization. sshClient # [ 1.743917] systemd[1]: Reached target Basic System. machine # [ 2.046930] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 2.059171] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) sshClient # [ 2.033349] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 2.061038] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.066066] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.070527] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 2.071221] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 2.072907] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 sshClient # [ 2.045700] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 2.081473] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 2.082387] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 2.084582] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 2.085360] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.086514] usb usb1: Product: EHCI Host Controller machine # [ 2.087171] usb usb1: Manufacturer: Linux 6.18.52 ehci_hcd machine # [ 2.090455] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 2.091343] hub 1-0:1.0: USB hub found machine # [ 2.093017] hub 1-0:1.0: 6 ports detected machine # [ 2.097706] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 2.103448] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 sshClient # [ 2.076878] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.110923] uhci_hcd 0000:00:1d.0: detected 2 ports sshClient # [ 2.087130] ehci-pci 0000:00:1d.7: EHCI Host Controller sshClient # [ 2.087921] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 sshClient # [ 2.089247] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 2.119281] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 sshClient # [ 2.093704] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.124770] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.125948] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 2.098976] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 sshClient # [ 2.099918] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 sshClient # [ 2.101529] serio: i8042 AUX port at 0x60,0x64 irq 12 sshClient # [ 2.102362] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 2.104237] usb usb1: Product: EHCI Host Controller sshClient # [ 2.105965] usb usb1: Manufacturer: Linux 6.18.52 ehci_hcd sshClient # [ 2.108963] usb usb1: SerialNumber: 0000:00:1d.7 sshClient # [ 2.110540] hub 1-0:1.0: USB hub found sshClient # [ 2.112262] hub 1-0:1.0: 6 ports detected machine # [ 2.143695] usb usb2: Product: UHCI Host Controller sshClient # [ 2.120679] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 2.149591] usb usb2: Manufacturer: Linux 6.18.52 uhci_hcd machine # [ 2.150325] usb usb2: SerialNumber: 0000:00:1d.0 sshClient # [ 2.130022] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 2.161929] hub 2-0:1.0: USB hub found machine # [ 2.163271] SCSI subsystem initialized machine # [ 2.171581] hub 2-0:1.0: 2 ports detected sshClient # [ 2.144044] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 2.034216] systemd[1]: Starting Virtual Console Setup... sshClient # [ 2.153307] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 sshClient # [ 2.167039] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 2.168471] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.196631] uhci_hcd 0000:00:1d.1: UHCI Host Controller sshClient # [ 2.039815] systemd[1]: Starting Virtual Console Setup... machine # [ 2.071165] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.214830] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 sshClient # [ 2.051346] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 2.053959] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.077688] systemd[1]: Finished Virtual Console Setup. sshClient # [ 2.196583] usb usb2: Product: UHCI Host Controller machine # [ 2.229458] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 sshClient # [ 2.203763] usb usb2: Manufacturer: Linux 6.18.52 uhci_hcd machine # [ 2.091387] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 2.206052] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 2.093376] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. sshClient # [ 2.207808] SCSI subsystem initialized machine # [ 2.237477] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 2.103458] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.105807] systemd[1]: Reached target Initrd Root Device. machine # [ 2.109076] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.250706] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 sshClient # [ 2.224739] hub 2-0:1.0: USB hub found sshClient # [ 2.094097] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.258610] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 2.232254] hub 2-0:1.0: 2 ports detected sshClient # [ 2.097952] systemd[1]: Finished Virtual Console Setup. sshClient # [ 2.242019] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.271472] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 2.109638] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.273550] usb usb3: Product: UHCI Host Controller machine # [ 2.274251] usb usb3: Manufacturer: Linux 6.18.52 uhci_hcd sshClient # [ 2.112537] systemd[1]: Reached target Initrd Root Device. sshClient # [ 2.113669] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.278584] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 2.280696] hub 3-0:1.0: USB hub found sshClient # [ 2.254030] uhci_hcd 0000:00:1d.1: UHCI Host Controller sshClient # [ 2.254802] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 2.283476] hub 3-0:1.0: 2 ports detected machine # [ 2.291868] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 2.265004] uhci_hcd 0000:00:1d.1: detected 2 ports sshClient # [ 2.265818] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 2.295549] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 2.158347] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.300506] uhci_hcd 0000:00:1d.2: detected 2 ports sshClient # [ 2.272888] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.301323] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 sshClient # [ 2.275324] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.164953] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. sshClient # [ 2.279017] usb usb3: Product: UHCI Host Controller sshClient # [ 2.279752] usb usb3: Manufacturer: Linux 6.18.52 uhci_hcd sshClient # [ 2.280986] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 2.311236] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 2.286096] hub 3-0:1.0: USB hub found machine # [ 2.313524] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 2.151819] systemd-fsck[105]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.316485] usb usb4: Product: UHCI Host Controller machine # [ 2.317188] usb usb4: Manufacturer: Linux 6.18.52 uhci_hcd sshClient # [ 2.289985] hub 3-0:1.0: 2 ports detected machine # [ 2.320477] usb usb4: SerialNumber: 0000:00:1d.2 sshClient # [ 2.157962] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.322837] hub 4-0:1.0: USB hub found machine # [ 2.324473] hub 4-0:1.0: 2 ports detected sshClient # [ 2.297060] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 2.297827] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 sshClient # [ 2.304031] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 2.331466] usb 1-1: new high-speed USB device number 2 using ehci-pci sshClient # [ 2.304857] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 sshClient # [ 2.307272] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.336909] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode sshClient # [ 2.310980] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 2.312984] usb usb4: Product: UHCI Host Controller sshClient # [ 2.313712] usb usb4: Manufacturer: Linux 6.18.52 uhci_hcd sshClient # [ 2.319090] usb usb4: SerialNumber: 0000:00:1d.2 sshClient # [ 2.322431] hub 4-0:1.0: USB hub found machine # [ 2.351261] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.352177] ahci 0000:00:1f.2: flags: 64bit ncq only sshClient # [ 2.325344] hub 4-0:1.0: 2 ports detected machine # [ 2.365963] scsi host0: ahci machine # [ 2.367697] scsi host1: ahci machine # [ 2.370229] scsi host2: ahci machine # [ 2.372488] scsi host3: ahci machine # [ 2.374151] scsi host4: ahci machine # [ 2.375882] scsi host5: ahci machine # [ 2.377345] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 2.378575] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 2.351957] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.379788] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 sshClient # [ 2.353113] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.380981] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.382154] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 2.383308] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 sshClient # [ 2.358917] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) sshClient # [ 2.360608] ahci 0000:00:1f.2: flags: 64bit ncq only sshClient # [ 2.365026] scsi host0: ahci sshClient # [ 2.366989] scsi host1: ahci sshClient # [ 2.368806] scsi host2: ahci sshClient # [ 2.370427] scsi host3: ahci sshClient # [ 2.372166] scsi host4: ahci sshClient # [ 2.373829] scsi host5: ahci sshClient # [ 2.374872] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 sshClient # [ 2.376557] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 2.377755] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 sshClient # [ 2.378968] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 sshClient # [ 2.380177] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 sshClient # [ 2.381312] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.460801] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.463300] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.465916] usb 1-1: Product: QEMU USB Tablet machine # [ 2.467376] usb 1-1: Manufacturer: QEMU machine # [ 2.468748] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.501899] hid: raw HID events driver (C) Jiri Kosina sshClient # [ 2.483003] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 sshClient # [ 2.484161] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 sshClient # [ 2.485413] usb 1-1: Product: QEMU USB Tablet sshClient # [ 2.486104] usb 1-1: Manufacturer: QEMU sshClient # [ 2.486657] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 sshClient # [ 2.500634] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.447357] systemd[1]: Mounting /sysroot... sshClient # [ 2.466484] systemd[1]: Mounting /sysroot... machine # [ 2.692039] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.700153] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.701306] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.702378] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.703307] ata3.00: applying bridge limits machine # [ 2.704334] ata3.00: configured for UDMA/100 machine # [ 2.705250] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.706313] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.707270] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.708695] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 sshClient # [ 2.693604] ata1: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.696019] ata2: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.698615] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) sshClient # [ 2.701230] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 sshClient # [ 2.703202] ata3.00: applying bridge limits sshClient # [ 2.705233] ata5: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.707559] ata4: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.709994] ata6: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.712192] ata3.00: configured for UDMA/100 sshClient # [ 2.714564] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.774668] usbcore: registered new interface driver usbhid machine # [ 2.777805] usbhid: USB HID core driver machine # [ 2.795602] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.806679] 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 machine # [ 2.808603] 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 machine # [ 2.812667] cdrom: Uniform CD-ROM driver Revision: 3.20 sshClient # [ 2.798063] usbcore: registered new interface driver usbhid machine # [ 2.828295] EXT4-fs (vda): mounted filesystem a9a6c362-25ac-4507-a72c-0735d5798d45 r/w with ordered data mode. Quota mode: none. sshClient # [ 2.802473] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray sshClient # [ 2.803417] usbhid: USB HID core driver machine # [ 2.696132] systemd[1]: Mounted /sysroot. machine # [ 2.697953] systemd[1]: Reached target Initrd Root File System. machine # [ 2.699819] systemd[1]: Starting Mountpoints Configured in the Real Root... sshClient # [ 2.820145] 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 sshClient # [ 2.821966] cdrom: Uniform CD-ROM driver Revision: 3.20 sshClient # [ 2.822912] 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 machine # [ 2.715747] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.718753] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.721244] systemd[1]: Reloading... sshClient # [ 2.854132] EXT4-fs (vda): mounted filesystem 36a59b13-2ab8-4bc2-90cf-54d866800dc5 r/w with ordered data mode. Quota mode: none. sshClient # [ 2.723345] systemd[1]: Mounted /sysroot. sshClient # [ 2.724132] systemd[1]: Reached target Initrd Root File System. sshClient # [ 2.729073] systemd[1]: Starting Mountpoints Configured in the Real Root... sshClient # [ 2.745550] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload. sshClient # [ 2.748503] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)... sshClient # [ 2.751118] systemd[1]: Reloading... machine # [ 2.796410] systemd[1]: Reloading finished in 75 ms. machine # [ 2.804464] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace... machine # [ 2.808262] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace... machine # [ 2.812036] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.814075] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.814988] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. sshClient # [ 2.815868] systemd[1]: Reloading finished in 65 ms. sshClient # [ 2.824226] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace... sshClient # [ 2.827991] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace... sshClient # [ 2.830790] systemd[1]: initrd-parse-etc.service: Deactivated successfully. sshClient # [ 2.832426] systemd[1]: Finished Mountpoints Configured in the Real Root. sshClient # [ 2.834134] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.447987] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.455166] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.463171] systemd[1]: Mounting /sysroot/run... machine # [ 3.474172] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.484792] systemd[1]: Mounting /sysroot/tmp/xchg... sshClient # [ 3.467274] systemd[1]: Mounting /sysroot/nix/.ro-store... sshClient # [ 3.475183] systemd[1]: Mounting /sysroot/nix/.rw-store... sshClient # [ 3.483173] systemd[1]: Mounting /sysroot/run... sshClient # [ 3.494204] systemd[1]: Mounting /sysroot/tmp/shared... sshClient # [ 3.505324] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.529931] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.532714] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.534875] systemd[1]: Mounted /sysroot/run. machine # [ 3.535584] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.538382] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.541688] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.552865] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.554719] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.542987] systemd[1]: Mounted /sysroot/nix/.ro-store. sshClient # [ 3.548115] systemd[1]: Mounted /sysroot/nix/.rw-store. sshClient # [ 3.549322] systemd[1]: Mounted /sysroot/run. sshClient # [ 3.550956] systemd[1]: Mounted /sysroot/tmp/shared. sshClient # [ 3.553607] systemd[1]: Mounted /sysroot/tmp/xchg. sshClient # [ 3.556856] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 3.567504] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 3.568936] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.571172] systemd[1]: Mounting /sysroot/nix/store... sshClient # [ 3.592618] systemd[1]: Mounted /sysroot/nix/store. sshClient # [ 3.593652] systemd[1]: Reached target Initrd File Systems. sshClient # [ 3.595213] systemd[1]: Starting Find NixOS closure... sshClient # [ 3.597749] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... sshClient # [ 3.615035] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. sshClient # [ 3.621776] systemd[1]: Finished Find NixOS closure. sshClient # [ 3.623156] systemd[1]: Reached target Initrd Default Target. sshClient # [ 3.624894] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... sshClient # [ 3.638087] systemd[1]: Stopped target Initrd Default Target. sshClient # [ 3.639426] systemd[1]: Stopped target Basic System. sshClient # [ 3.640315] systemd[1]: Stopped target Initrd Root Device. sshClient # [ 3.642109] systemd[1]: Stopped target Path Units. sshClient # [ 3.642797] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. sshClient # [ 3.643796] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. sshClient # [ 3.644964] systemd[1]: Stopped target Slice Units. sshClient # [ 3.645674] systemd[1]: Stopped target Socket Units. sshClient # [ 3.646383] systemd[1]: Stopped target System Initialization. sshClient # [ 3.647334] systemd[1]: Stopped target Swaps. sshClient # [ 3.648222] systemd[1]: Stopped target Timer Units. sshClient # [ 3.649119] systemd[1]: dbus.socket: Deactivated successfully. sshClient # [ 3.650634] systemd[1]: Closed D-Bus System Message Bus Socket. sshClient # [ 3.651453] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. sshClient # [ 3.652424] systemd[1]: Stopped Find NixOS closure. sshClient # [ 3.653411] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 3.655170] systemd[1]: systemd-sysctl.service: Deactivated successfully. sshClient # [ 3.656273] systemd[1]: Stopped Apply Kernel Variables. sshClient # [ 3.657320] systemd[1]: systemd-modules-load.service: Deactivated successfully. sshClient # [ 3.658441] systemd[1]: Stopped Load Kernel Modules. sshClient # [ 3.659402] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. sshClient # [ 3.660778] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. sshClient # [ 3.662097] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. sshClient # [ 3.663095] systemd[1]: Stopped Create System Files and Directories. sshClient # [ 3.665232] systemd[1]: Stopped target Local File Systems. sshClient # [ 3.666206] systemd[1]: Stopped target Preparation for Local File Systems. sshClient # [ 3.667261] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. sshClient # [ 3.669102] systemd[1]: Stopped Coldplug All udev Devices. sshClient # [ 3.671594] systemd[1]: Stopping Rule-based Manager for Device Events and Files... sshClient # [ 3.672609] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 3.673607] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 3.680426] systemd[1]: initrd-cleanup.service: Deactivated successfully. sshClient # [ 3.685084] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. sshClient # [ 3.687813] systemd[1]: systemd-udevd.service: Deactivated successfully. sshClient # [ 3.690172] systemd[1]: Stopped Rule-based Manager for Device Events and Files. sshClient # [ 3.693993] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 3.695170] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.697535] systemd[1]: Starting Cleanup udev Database... sshClient # [ 3.698330] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. sshClient # [ 3.699345] systemd[1]: Stopped Create Static Device Nodes in /dev. sshClient # [ 3.701142] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. sshClient # [ 3.702273] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. sshClient # [ 3.703250] systemd[1]: kmod-static-nodes.service: Deactivated successfully. sshClient # [ 3.704166] systemd[1]: Stopped Create List of Static Device Nodes. sshClient # [ 3.719289] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. sshClient # [ 3.720400] systemd[1]: Finished Cleanup udev Database. sshClient # [ 3.721602] systemd[1]: Reached target Switch Root. sshClient # [ 3.723454] systemd[1]: Starting NixOS Activation... sshClient # [ 3.795442] initrd-nixos-activation-start[190]: booting system configuration /nix/store/qjzdwfqrb6c8ax0h3m4nfhakm0v6hx2d-nixos-system-sshClient-test sshClient # [ 3.822557] initrd-nixos-activation-start[190]: running activation script... sshClient # [ 4.001726] initrd-nixos-activation-start[213]: setting up /etc... sshClient # [ 4.094053] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. sshClient # [ 4.096084] systemd[1]: Finished NixOS Activation. sshClient # [ 4.097538] systemd[1]: Starting Switch Root... sshClient # [ 4.110953] systemd[1]: Switching root. sshClient # [ 4.374255] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). sshClient # [ 4.449507] NET: Registered PF_VSOCK protocol family machine # [ 4.446761] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.471892] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.474088] systemd[1]: Reached target Initrd File Systems. machine # [ 4.475851] systemd[1]: Starting Find NixOS closure... machine # [ 4.479134] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.499134] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.500939] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.508467] systemd[1]: Finished Find NixOS closure. machine # [ 4.510186] systemd[1]: Reached target Initrd Default Target. machine # [ 4.511737] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.526315] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.527401] systemd[1]: Stopped target Basic System. machine # [ 4.528301] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.529272] systemd[1]: Stopped target Path Units. machine # [ 4.530066] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.532117] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.533165] systemd[1]: Stopped target Slice Units. machine # [ 4.533839] systemd[1]: Stopped target Socket Units. machine # [ 4.534734] systemd[1]: Stopped target System Initialization. machine # [ 4.535548] systemd[1]: Stopped target Swaps. machine # [ 4.536214] systemd[1]: Stopped target Timer Units. machine # [ 4.536907] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.537979] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.539112] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.541049] systemd[1]: Stopped Find NixOS closure. machine # [ 4.542241] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.544106] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.545245] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.546292] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.547438] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.548411] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.549848] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.551159] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.553321] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.554245] systemd[1]: Stopped target Local File Systems. machine # [ 4.554970] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.556107] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.557591] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.558428] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.559804] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.561106] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.572721] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.576073] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.578728] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.580090] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.586388] systemd[1]: Starting Cleanup udev Database... machine # [ 4.588258] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.589296] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.590116] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.591173] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.592122] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.594068] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.594903] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.596113] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.615128] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.616948] systemd[1]: Finished Cleanup udev Database. machine # [ 4.618349] systemd[1]: Reached target Switch Root. machine # [ 4.620148] systemd[1]: Starting NixOS Activation... machine # [ 4.693551] initrd-nixos-activation-start[189]: booting system configuration /nix/store/8vhz6bkdb6yhgy27a8zd3p84wrl5f3a7-nixos-system-machine-test sshClient # [ 4.808319] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) sshClient # [ 4.817904] systemd[1]: Detected virtualization kvm. sshClient # [ 4.819705] systemd[1]: Detected architecture x86-64. sshClient # [ 4.821648] systemd[1]: Detected first boot. sshClient # [ 4.825811] systemd[1]: Initializing machine ID from random generator. machine # [ 4.717704] initrd-nixos-activation-start[189]: running activation script... sshClient # [ 4.933605] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.901976] initrd-nixos-activation-start[212]: setting up /etc... sshClient # [ 5.035304] systemd[1]: Applying preset policy. machine # [ 4.995690] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.998066] systemd[1]: Finished NixOS Activation. machine # [ 4.999131] systemd[1]: Starting Switch Root... machine # [ 5.011967] systemd[1]: Switching root. sshClient # [ 5.217595] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.271216] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 5.323152] NET: Registered PF_VSOCK protocol family sshClient # [ 5.409244] systemd[1]: initrd-switch-root.service: Deactivated successfully. sshClient # [ 5.410574] systemd[1]: Stopped initrd-switch-root.service. sshClient # [ 5.412541] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. sshClient # [ 5.414640] systemd[1]: Created slice Slice /system/getty. sshClient # [ 5.416031] systemd[1]: Created slice User and Session Slice. sshClient # [ 5.416989] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 5.418161] systemd[1]: Started Forward Password Requests to Wall Directory Watch. sshClient # [ 5.419265] systemd[1]: Expecting device /dev/hvc0... sshClient # [ 5.419990] systemd[1]: Expecting device /dev/ttyS0... sshClient # [ 5.420727] systemd[1]: Reached target Local Encrypted Volumes. sshClient # [ 5.421598] systemd[1]: Stopped target initrd-fs.target. sshClient # [ 5.422363] systemd[1]: Stopped target initrd-root-fs.target. sshClient # [ 5.423152] systemd[1]: Stopped target initrd-switch-root.target. sshClient # [ 5.423973] systemd[1]: Reached target Virtual Machines and Containers. sshClient # [ 5.424901] systemd[1]: Reached target Path Units. sshClient # [ 5.425619] systemd[1]: Reached target Remote File Systems. sshClient # [ 5.426403] systemd[1]: Reached target Slice Units. sshClient # [ 5.427111] systemd[1]: Reached target Swaps. sshClient # [ 5.428692] systemd[1]: Listening on Query the User Interactively for a Password. sshClient # [ 5.443091] systemd[1]: Listening on Process Core Dump Socket. sshClient # [ 5.444749] systemd[1]: Listening on Credential Encryption/Decryption. sshClient # [ 5.446483] systemd[1]: Listening on Factory Reset Management. sshClient # [ 5.447395] systemd[1]: Listening on Hostname Service Socket. sshClient # [ 5.450256] systemd[1]: Starting Journal Log Access Socket... sshClient # [ 5.451476] systemd[1]: Listening on Journal Audit Socket. sshClient # [ 5.453834] systemd[1]: Listening on Console Output Muting Service Socket. sshClient # [ 5.455233] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. sshClient # [ 5.456316] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.457620] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki sshClient # [ 5.461467] systemd[1]: Listening on Disk Repartitioning Service Socket. sshClient # [ 5.462536] systemd[1]: Listening on udev Varlink Socket. sshClient # [ 5.463416] systemd[1]: Listening on User Database Manager Socket. sshClient # [ 5.465829] systemd[1]: Mounting Huge Pages File System... sshClient # [ 5.469002] systemd[1]: Mounting POSIX Message Queue File System... sshClient # [ 5.475083] systemd[1]: Mounting Kernel Debug File System... sshClient # [ 5.482677] systemd[1]: Mounting Kernel Trace File System... sshClient # [ 5.493380] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 5.510027] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 5.519463] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm sshClient # [ 5.528341] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore sshClient # [ 5.540064] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 5.551981] systemd[1]: Mounting FUSE Control File System... sshClient # [ 5.552910] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 5.567249] systemd[1]: Starting Journal Service... sshClient # [ 5.574594] systemd[1]: Starting Load Kernel Modules... sshClient # [ 5.584256] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... sshClient # [ 5.594809] systemd[1]: Starting Remount Root and Kernel File Systems... sshClient # [ 5.599478] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.605754] systemd[1]: Starting Coldplug All udev Devices... sshClient # [ 5.617701] systemd[1]: Listening on Journal Log Access Socket. sshClient # [ 5.624988] systemd[1]: Mounted Huge Pages File System. sshClient # [ 5.625896] systemd[1]: Mounted POSIX Message Queue File System. sshClient # [ 5.627488] systemd-journald[284]: Collecting audit messages is enabled. sshClient # [ 5.632103] systemd[1]: Mounted Kernel Debug File System. sshClient # [ 5.637857] systemd[1]: Mounted Kernel Trace File System. sshClient # [ 5.643274] systemd[1]: Finished Create List of Static Device Nodes. sshClient # [ 5.648591] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 5.676973] systemd[1]: systemd 262-e362a4e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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) machine # [ 5.680859] systemd[1]: Detected virtualization kvm. machine # [ 5.681585] systemd[1]: Detected architecture x86-64. machine # [ 5.682319] systemd[1]: Detected first boot. sshClient # [ 5.656011] systemd[1]: Finished Load Kernel Module configfs. machine # [ 5.684368] systemd[1]: Initializing machine ID from random generator. sshClient # [ 5.521413] systemd[1]: Queued start job for default target Multi-User System. sshClient # [ 5.522602] systemd[1]: systemd-journald.service: Deactivated successfully. sshClient # [ 5.662252] systemd[1]: Started Journal Service. sshClient # [ 5.532062] systemd[1]: Mounted FUSE Control File System. sshClient # [ 5.547081] systemd[1]: Mounting Kernel Configuration File System... sshClient # [ 5.549478] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 5.703302] loop: module loaded sshClient # [ 5.570370] systemd-modules-load[285]: Inserted module 'loop' sshClient # [ 5.709003] EXT4-fs (vda): re-mounted 36a59b13-2ab8-4bc2-90cf-54d866800dc5. sshClient # [ 5.587620] systemd[1]: Finished Load Kernel Modules. sshClient # [ 5.590439] systemd[1]: Finished Remount Root and Kernel File Systems. sshClient # [ 5.593737] systemd[1]: Listening on Disk Image Download Service Socket. sshClient # [ 5.598107] systemd[1]: Starting Firewall... sshClient # [ 5.604510] systemd-oomd[286]: No swap; memory pressure usage will be degraded machine # [ 5.768601] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 5.607393] systemd[1]: Starting Flush Journal to Persistent Storage... sshClient # [ 5.611068] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 5.623131] systemd[1]: Starting Load/Save OS Random Seed... sshClient # [ 5.631947] systemd[1]: Starting Apply Kernel Variables... sshClient # [ 5.632793] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.634224] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. sshClient # [ 5.825293] systemd-journald[284]: Received client request to flush runtime journal. machine # [ 5.862121] systemd[1]: Applying preset policy. sshClient # [ 5.788413] systemd[1]: Mounted Kernel Configuration File System. sshClient # [ 5.793386] systemd[1]: Finished Load/Save OS Random Seed. sshClient # [ 5.794285] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. sshClient # [ 5.795281] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 5.799289] systemd[1]: Finished Flush Journal to Persistent Storage. sshClient # [ 5.808927] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.048041] systemd[1]: Populated /etc with preset unit settings. sshClient # [ 5.893507] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 5.902465] systemd[1]: Finished Create Static Device Nodes in /dev. sshClient # [ 5.903631] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 5.906194] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 5.950564] systemd-udevd[322]: Using default interface naming scheme 'v261'. sshClient # [ 5.960941] systemd[1]: Starting User Database Manager... sshClient # [ 5.997916] systemd[1]: Started User Database Manager. sshClient # [ 6.050098] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.222236] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.223635] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.225893] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.228013] systemd[1]: Created slice Slice /system/getty. machine # [ 6.229367] systemd[1]: Created slice User and Session Slice. machine # [ 6.230289] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.231517] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.232665] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.233360] systemd[1]: Expecting device /dev/ttyS0... machine # [ 6.234120] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.234981] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.235761] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.236588] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.237448] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.238353] systemd[1]: Reached target Path Units. machine # [ 6.239044] systemd[1]: Reached target Remote File Systems. machine # [ 6.239850] systemd[1]: Reached target Slice Units. machine # [ 6.240585] systemd[1]: Reached target Swaps. machine # [ 6.242022] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.256149] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.257987] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.259768] systemd[1]: Listening on Factory Reset Management. machine # [ 6.260744] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.263357] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.264849] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.267541] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.268640] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.269800] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.271144] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.275083] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.276161] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.277091] systemd[1]: Listening on User Database Manager Socket. machine # [ 6.279585] systemd[1]: Mounting Huge Pages File System... machine # [ 6.281851] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.288819] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.297467] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.307098] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.320503] systemd[1]: Starting Load Kernel Module configfs... machine # [ 6.321352] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm sshClient # [ 6.160970] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.337909] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.342981] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.353449] systemd[1]: Mounting FUSE Control File System... machine # [ 6.362820] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.377183] systemd[1]: Starting Journal Service... machine # [ 6.387681] systemd[1]: Starting Load Kernel Modules... machine # [ 6.396008] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.403502] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.408761] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.255920] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.425099] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.439584] systemd-journald[283]: Collecting audit messages is enabled. machine # [ 6.441119] systemd[1]: Listening on Journal Log Access Socket. sshClient # [ 6.278076] systemd[1]: Mounting /run/wrappers... machine # [ 6.445050] systemd[1]: Mounted Huge Pages File System. sshClient # [ 6.281518] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 6.447332] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.451152] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.454684] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.460472] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.322107] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.326895] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.469177] systemd[1]: Started Journal Service. sshClient # [ 6.313237] (udev-worker)[360]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 6.337378] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 6.481114] loop: module loaded sshClient # [ 6.318427] (udev-worker)[360]: Network interface NamePolicy= disabled on kernel command line. machine # [ 6.343140] systemd[1]: Finished Load Kernel Module configfs. machine # [ 6.346434] systemd-modules-load[284]: Inserted module 'loop' sshClient # [ 6.325547] systemd[1]: Mounted /run/wrappers. machine # [ 6.349203] systemd[1]: Mounted FUSE Control File System. sshClient # [ 6.326412] systemd[1]: Reached target Local File Systems. machine # [ 6.493478] EXT4-fs (vda): re-mounted a9a6c362-25ac-4507-a72c-0735d5798d45. sshClient # [ 6.330604] systemd[1]: Listening on Boot Loader Control Service Socket. sshClient # [ 6.333323] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.357113] systemd[1]: Finished Load Kernel Modules. sshClient # [ 6.334197] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 6.339100] systemd[1]: Starting Create System Files and Directories... machine # [ 6.366584] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.370893] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.378072] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.382649] systemd[1]: Starting Firewall... machine # [ 6.387547] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.388531] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.399088] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.418083] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.432233] systemd-oomd[285]: No swap; memory pressure usage will be degraded machine # [ 6.436069] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.437091] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.446562] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. sshClient # [ 6.453747] systemd[1]: Finished Create System Files and Directories. sshClient # [ 6.459918] systemd[1]: Starting Rebuild Journal Catalog... sshClient # [ 6.464256] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.629831] systemd-journald[283]: Received client request to flush runtime journal. sshClient # [ 6.554447] systemd[1]: Finished Record System Boot/Shutdown in UTMP. sshClient # [ 6.573174] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.596587] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.598282] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.600814] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 6.577674] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore sshClient # [ 6.579179] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.603348] systemd[1]: Finished Flush Journal to Persistent Storage. sshClient # [ 6.580533] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 6.583287] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 6.586089] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.588623] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.594778] systemd[1]: Finished Rebuild Journal Catalog. sshClient # [ 6.601688] systemd[1]: Starting Update is Completed... machine # [ 6.639080] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.645587] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 6.658278] systemd[1]: Finished Update is Completed. machine # [ 6.713994] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.724755] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.726201] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.728696] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 6.881886] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 6.775225] systemd-udevd[326]: Using default interface naming scheme 'v261'. sshClient # [ 6.895726] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 6.786258] systemd[1]: Starting User Database Manager... machine # [ 6.824124] systemd[1]: Started User Database Manager. machine # [ 6.873104] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 6.867974] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. sshClient # [ 6.872257] systemd[1]: Finished Create SUID/SGID Wrappers. sshClient # [ 6.874592] systemd[1]: Reached target System Initialization. sshClient # [ 6.878081] systemd[1]: Started Discard unused filesystem blocks once a week. sshClient # [ 6.879119] systemd[1]: Started Daily Cleanup of Temporary Directories. sshClient # [ 6.880066] systemd[1]: Reached target Timer Units. sshClient # [ 6.880746] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 6.881598] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. sshClient # [ 6.883319] systemd[1]: Reached target Socket Units. sshClient # [ 6.885215] systemd[1]: Reached target Basic System. sshClient # [ 6.889138] systemd[1]: Started backdoor.service. sshClient # [ 6.894087] systemd[1]: Starting Import lastlog data into lastlog2 database... sshClient # [ 6.903978] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 6.913058] systemd[1]: Starting Post-Boot Actions... sshClient # [ 6.926081] systemd[1]: Started Reset console on configuration changes. sshClient # [ 6.931085] ACPI: button: Power Button [PWRF] machine # [ 6.989929] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 7.019795] systemd[1]: Starting resolvconf update... sshClient # [ 7.026740] systemd[1]: Starting Home Area Manager... sshClient # [ 7.037604] systemd[1]: Finished Firewall. sshClient # [ 7.040427] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.074192] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. sshClient # connecting to host... machine # [ 7.085764] systemd[1]: Mounting /run/wrappers... sshClient # [ 7.067881] systemd[1]: Finished Post-Boot Actions. machine # [ 7.098106] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. sshClient # [ 7.092808] nsncd[504]: Sep 22 03:03:18.639 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.096864] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.097839] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 7.102086] systemd[1]: Reached target User and Group Name Lookups. sshClient # [ 6.962073] mousedev: PS/2 mouse device common for all mice sshClient # [ 7.054880] rtc_cmos PNP0B00:00: RTC can wake from S4 sshClient # [ 7.086229] rtc_cmos PNP0B00:00: registered as rtc0 sshClient # [ 7.086317] rtc_cmos PNP0B00:00: setting system clock to 2026-09-22T03:03:18 UTC (1790046198) machine # [ 7.134783] systemd[1]: Mounted /run/wrappers. machine # [ 7.135523] systemd[1]: Reached target Local File Systems. machine # [ 7.139647] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.140772] (udev-worker)[361]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 7.119129] systemd[1]: Starting User Login Management... machine # [ 7.142655] (udev-worker)[361]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.146403] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.147300] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.151769] systemd[1]: Starting Create System Files and Directories... sshClient # [ 7.143242] systemd-homed[508]: Watching /home. sshClient # [ 7.168988] systemd[1]: Finished Import lastlog data into lastlog2 database. sshClient # [ 7.086393] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs sshClient # [ 7.088364] systemd-journald[284]: Time jumped backwards, rotating. sshClient # [ 7.100816] Console: switching to colour dummy device 80x25 sshClient # [ 7.168880] parport_pc 00:02: reported by Plug and Play ACPI sshClient # [ 7.222868] dbus-broker-launch[513]: Looking up NSS user entry for 'systemd-timesync'... sshClient # [ 7.227508] dbus-broker-launch[513]: NSS returned no entry for 'systemd-timesync' sshClient # [ 7.228586] dbus-broker-launch[513]: Invalid user-name in /nix/store/3wca9l9n48mwjff4rq5wxn7bjvxghwjd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 7.253550] systemd[1]: Finished Create System Files and Directories. machine # [ 7.261110] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.263536] systemd[1]: Starting Record System Boot/Shutdown in UTMP... sshClient # [ 7.179616] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 sshClient # [ 7.236017] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized sshClient # [ 7.257717] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] sshClient # [ 7.267182] systemd[1]: Started D-Bus System Message Bus. sshClient # [ 7.301763] systemd[1]: Stopped target Host and Network Name Lookups. sshClient # [ 7.302679] systemd[1]: Stopping Host and Network Name Lookups... sshClient # [ 7.303510] systemd[1]: Stopped target User and Group Name Lookups. sshClient # [ 7.304464] systemd[1]: Stopping User and Group Name Lookups... sshClient # [ 7.307594] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... sshClient # [ 7.308501] systemd[1]: nscd.service: Deactivated successfully. sshClient # [ 7.309290] systemd[1]: Stopped Name Service Cache Daemon (nsncd). sshClient # [ 7.310290] dbus-broker-launch[513]: Ready sshClient # [ 7.310945] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 7.314587] systemd-logind[534]: New seat seat0. machine # [ 7.337874] systemd[1]: Finished Record System Boot/Shutdown in UTMP. sshClient # [ 7.315340] systemd[1]: Started User Login Management. sshClient # [ 7.320142] systemd[1]: Starting linger-users.service... sshClient # [ 7.320907] systemd[1]: Started Home Area Manager. sshClient # [ 7.326653] systemd[1]: Finished Home Area Activation. machine # [ 7.353161] systemd[1]: Finished Rebuild Journal Catalog. sshClient # [ 7.466315] [drm] Found bochs VGA, ID 0xb0c5. sshClient # [ 7.466777] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.359400] systemd[1]: Starting Update is Completed... sshClient # [ 7.473404] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt sshClient # [ 7.474161] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD sshClient # [ 7.344789] systemd[1]: Starting First Boot Home Area Wizard... sshClient # [ 7.511087] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 7.398156] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 7.511816] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 7.399268] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.400631] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.401790] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.403753] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.406327] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.408187] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.412146] systemd[1]: Finished Update is Completed. sshClient # [ 7.396322] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.397530] nsncd[583]: Sep 22 03:03:18.945 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.401894] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 7.404366] systemd[1]: Reached target User and Group Name Lookups. sshClient # [ 7.409383] systemd[1]: linger-users.service: Deactivated successfully. sshClient # [ 7.411206] systemd[1]: Finished linger-users.service. sshClient # [ 7.425095] systemd[1]: Finished resolvconf update. sshClient # [ 7.428769] systemd[1]: Reached target Preparation for Network. sshClient # [ 7.434177] systemd[1]: Starting DHCP Client... sshClient # [ 7.438966] systemd[1]: Starting Address configuration of eth1... sshClient # [ 7.446891] systemd[1]: Starting Extra networking commands.... sshClient # [ 7.462153] systemd[1]: Finished First Boot Home Area Wizard. sshClient # [ 7.603657] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 sshClient # [ 7.607719] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 sshClient # [ 7.475438] systemd[1]: Reached target First Boot Complete. sshClient # [ 7.480753] systemd[1]: Starting Save Transient machine-id to Disk... sshClient # [ 7.554869] systemd[1]: Starting Virtual Console Setup... machine # [ 7.720926] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 7.732368] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 7.609545] systemd[1]: Finished Firewall. machine # [ 7.643440] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.646857] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.647721] systemd[1]: Reached target System Initialization. machine # [ 7.649779] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.650836] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.653930] systemd[1]: Reached target Timer Units. machine # [ 7.654697] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 7.768260] Console: switching to colour frame buffer device 160x50 machine # [ 7.655601] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine # [ 7.656777] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 7.658413] systemd[1]: Reached target Socket Units. machine # [ 7.659336] systemd[1]: Reached target Basic System. machine # [ 7.661185] systemd[1]: Started backdoor.service. machine # [ 7.664136] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.675965] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.687274] systemd[1]: Starting Post-Boot Actions... machine # [ 7.696532] systemd[1]: Started Reset console on configuration changes. machine # [ 7.718632] systemd[1]: Starting resolvconf update... machine # [ 7.727748] systemd[1]: Starting SSH Host Keys Generation... sshClient # [ 7.840982] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device sshClient # [ 7.620916] network-addresses-eth1-start[613]: adding address 192.168.1.2/24... done sshClient # [ 7.710377] network-addresses-eth1-start[613]: adding address 2001:db8:1::2/64... done sshClient # [ 7.711404] systemd-logind[534]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) sshClient # [ 7.714425] systemd-logind[534]: Watching system buttons on /dev/input/event2 (Power Button) sshClient # [ 7.717931] systemd[1]: Finished Address configuration of eth1. sshClient # [ 7.721206] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.724255] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 7.734966] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.752577] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. sshClient # [ 7.759727] systemd[1]: Finished Save Transient machine-id to Disk. sshClient # [ 7.764614] dhcpcd[626]: dhcpcd-10.3.2 starting sshClient # [ 7.775780] dhcpcd[683]: dev: loaded udev sshClient # [ 7.783172] systemd[1]: Finished Extra networking commands.. sshClient # [ 7.786241] systemd[1]: Reached target Network. sshClient # [ 7.791605] systemd[1]: Starting Permit User Sessions... machine # connecting to host... sshClient # [ 7.946493] 8021q: 802.1Q VLAN Support v1.8 sshClient # [ 7.946950] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 7.839130] systemd[1]: Starting Home Area Manager... machine # [ 7.848408] systemd[1]: Starting D-Bus System Message Bus... sshClient # [ 7.832466] systemd[1]: Finished Permit User Sessions. machine # [ 7.855465] nsncd[510]: Sep 22 03:03:19.612 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.838064] systemd[1]: Started Getty on tty1. sshClient # [ 7.839165] systemd[1]: Reached target Login Prompts. machine # [ 7.862507] systemd[1]: Finished Post-Boot Actions. machine # [ 7.868609] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.848062] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) sshClient # [ 7.985299] ppdev: user-space parallel port driver machine: Guest shell says: b'Spawning backdoor root shell...\n' sshClient # [ 7.990990] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine: connected to guest root shell machine: (connecting took 8.57 seconds) machine: (finished: waiting for the VM to finish booting, in 8.57 seconds) machine # [ 7.897039] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.897898] systemd[1]: Reached target User and Group Name Lookups. sshClient # [ 8.023090] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 7.922697] systemd[1]: Starting User Login Management... machine # [ 7.756172] mousedev: PS/2 mouse device common for all mice machine # [ 7.756559] ACPI: button: Power Button [PWRF] machine # [ 7.959333] systemd-homed[518]: Watching /home. sshClient # [ 7.944470] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 7.813288] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.860360] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 7.874297] rtc_cmos PNP0B00:00: setting system clock to 2026-09-22T03:03:19 UTC (1790046199) sshClient # [ 8.113667] cfg80211: Loading compiled-in X.509 certificates for regulatory database sshClient # [ 7.984082] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.985568] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.010101] systemd[1]: Finished Import lastlog data into lastlog2 database. sshClient # [ 7.993150] systemd[1]: Starting Virtual Console Setup... machine # [ 7.874458] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.876148] systemd-journald[283]: Time jumped backwards, rotating. machine # [ 7.911149] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 7.911250] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 8.061840] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 sshClient # [ 8.202431] kvm_amd: TSC scaling supported sshClient # [ 8.202862] kvm_amd: Nested Virtualization enabled sshClient # [ 8.203632] kvm_amd: Nested Paging enabled sshClient # [ 8.204187] kvm_amd: LBR virtualization supported sshClient # [ 8.204693] kvm_amd: Virtual VMLOAD VMSAVE supported sshClient # [ 8.205383] kvm_amd: Virtual GIF supported sshClient # [ 8.205781] kvm_amd: Virtual NMI enabled sshClient # [ 8.210331] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' sshClient # [ 8.211062] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' sshClient # [ 8.213361] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 sshClient # [ 8.214191] cfg80211: failed to load regulatory.db machine # [ 8.112088] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.112976] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.113834] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.114705] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.115522] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.118703] dbus-broker-launch[521]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.123032] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.126118] dbus-broker-launch[521]: NSS returned no entry for 'systemd-timesync' machine # [ 8.128936] dbus-broker-launch[521]: Invalid user-name in /nix/store/6z2a7f6z73rkk439j25cxml11a07kp5a-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.130939] systemd[1]: Stopped Name Service Cache Daemon (nsncd). sshClient # [ 8.253411] EDAC MC: Ver: 3.0.0 sshClient # [ 8.264100] 8021q: adding VLAN 0 to HW filter on device eth0 sshClient # [ 8.129511] dhcpcd[683]: eth0: waiting for carrier sshClient # [ 8.130616] dhcpcd[683]: libudev: received NULL device sshClient # [ 8.131382] dhcpcd[683]: libudev: received NULL device sshClient # [ 8.132375] dhcpcd[683]: eth0: carrier acquired sshClient # [ 8.137788] dhcpcd[683]: DUID 00:01:00:01:32:44:ac:77:52:54:00:12:34:56 machine # [ 8.067497] Console: switching to colour dummy device 80x25 sshClient # [ 8.138709] dhcpcd[683]: eth0: IAID 00:12:34:56 machine # [ 8.109368] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized sshClient # [ 8.139335] dhcpcd[683]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 8.303198] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 8.303200] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 8.151333] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.167076] systemd-logind[547]: New seat seat0. machine # [ 8.171538] systemd[1]: Started User Login Management. machine # [ 8.177588] systemd[1]: Starting linger-users.service... machine # [ 8.182311] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.352261] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 8.352991] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 8.221825] dbus-broker-launch[521]: Ready sshClient # [ 8.203317] systemd-vconsole-setup[696]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.228079] systemd[1]: Started Home Area Manager. sshClient # [ 8.206485] systemd[1]: Finished Virtual Console Setup. machine # [ 8.230667] systemd[1]: Finished Home Area Activation. machine # [ 8.239950] systemd[1]: Starting First Boot Home Area Wizard... machine # [ 8.285411] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.286791] nsncd[596]: Sep 22 03:03:20.050 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.291149] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.291956] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.306592] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.450538] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 8.451201] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 8.314212] systemd[1]: Finished linger-users.service. machine # [ 8.345162] systemd[1]: Created slice Slice /system/systemd-mute-console. machine # [ 8.353068] systemd[1]: Started Console Output Muting Service (PID 609/UID 0). machine # [ 8.375886] systemd[1]: Finished resolvconf update. machine # [ 8.378452] systemd[1]: Reached target Preparation for Network. machine # [ 8.387632] systemd[1]: Starting DHCP Client... machine # [ 8.393233] systemd[1]: Starting Address configuration of eth1... machine # [ 8.399198] systemd[1]: Starting Extra networking commands.... machine # [ 8.481323] systemd[1]: Starting Virtual Console Setup... machine # [ 8.588542] network-addresses-eth1-start[631]: adding address 192.168.1.1/24... done machine # [ 8.614729] systemd-logind[547]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 8.628653] network-addresses-eth1-start[631]: adding address 2001:db8:1::1/64... done machine # [ 8.639334] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.640454] systemd-logind[547]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 8.646227] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.661795] systemd[1]: Starting Virtual Console Setup... machine # [ 8.670503] systemd[1]: Finished Address configuration of eth1. machine # [ 8.770323] dhcpcd[642]: dhcpcd-10.3.2 starting machine # [ 8.783811] dhcpcd[698]: dev: loaded udev machine # [ 8.819321] systemd[1]: Finished Extra networking commands.. machine # [ 8.822221] systemd[1]: Reached target Network. machine # [ 8.877217] systemd-logind[547]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 8.988779] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.991119] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.998284] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 9.003390] systemd[1]: Starting Virtual Console Setup... machine: (finished: waiting for unit systemd-homed.service, in 9.83 seconds) machine: waiting for Please enter user name to create to appear on tty 1 machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 0.13 seconds) machine: sending keys 'test-homed-user\n' machine # [ 9.308863] dhcpcd[698]: eth0: waiting for carrier machine # [ 9.309893] dhcpcd[698]: libudev: received NULL device machine # [ 9.310642] dhcpcd[698]: libudev: received NULL device machine # [ 9.311759] dhcpcd[698]: eth0: carrier acquired machine # [ 9.323528] dhcpcd[698]: DUID 00:01:00:01:32:44:ac:79:52:54:00:12:34:56 machine # [ 9.324471] dhcpcd[698]: eth0: IAID 00:12:34:56 machine # [ 9.325378] dhcpcd[698]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 9.446362] sshd-keygen-start[553]: Generating public/private rsa key pair. machine # [ 9.447392] sshd-keygen-start[553]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine # [ 9.448509] sshd-keygen-start[553]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds) machine: waiting for Please enter new password for user test-homed-user: to appear on tty 1 machine # [ 9.450187] sshd-keygen-start[553]: The key fingerprint is: machine # [ 9.450869] sshd-keygen-start[553]: SHA256:7OckhB01KSS+VyP8K7S9oPzFRp4P9gJIAN9WyFGDp5U root@machine machine # [ 9.452525] sshd-keygen-start[553]: The key's randomart image is: machine # [ 9.453407] sshd-keygen-start[553]: +---[RSA 4096]----+ machine # [ 9.454119] sshd-keygen-start[553]: | .. .o*=.o. | machine # [ 9.454772] sshd-keygen-start[553]: | ..o++Eo.. | machine # [ 9.455489] sshd-keygen-start[553]: | ..+++.o | machine # [ 9.456171] sshd-keygen-start[553]: | .o= = . | machine # [ 9.456869] sshd-keygen-start[553]: | .o.S o | machine # [ 9.458551] sshd-keygen-start[553]: | .=.* o | machine # [ 9.460537] sshd-keygen-start[553]: | *.& | machine # [ 9.462521] sshd-keygen-start[553]: | . . @.= | machine # [ 9.463293] sshd-keygen-start[553]: | o.. o.o | machine # [ 9.463925] sshd-keygen-start[553]: +----[SHA256]-----+ machine # [ 9.496420] sshd-keygen-start[745]: Generating public/private ed25519 key pair. machine # [ 9.497718] sshd-keygen-start[745]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine # [ 9.498956] sshd-keygen-start[745]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine # [ 9.500102] sshd-keygen-start[745]: The key fingerprint is: machine # [ 9.500765] sshd-keygen-start[745]: SHA256:MKYOEvZLfM0ysbOlpbL4OwwkRVOaOpQgvRhXwQxCZRU root@machine machine # [ 9.502157] sshd-keygen-start[745]: The key's randomart image is: machine # [ 9.502978] sshd-keygen-start[745]: +--[ED25519 256]--+ machine # [ 9.503954] sshd-keygen-start[745]: |=+=O=E. | machine # [ 9.504709] sshd-keygen-start[745]: |+.*+o | machine # [ 9.505388] sshd-keygen-start[745]: |.Oo. .+ | machine # [ 9.506064] sshd-keygen-start[745]: |=++ o=o | machine # [ 9.506711] sshd-keygen-start[745]: |* .+.* =S | sshClient # [ 9.482865] dhcpcd[683]: eth0: soliciting a DHCP lease machine # [ 9.507377] sshd-keygen-start[745]: | +.oo X | machine # [ 9.509074] sshd-keygen-start[745]: | oo.+ | machine # [ 9.509845] sshd-keygen-start[745]: | .oo | machine # [ 9.510847] sshd-keygen-start[745]: | ..+o | machine # [ 9.511690] sshd-keygen-start[745]: +----[SHA256]-----+ machine # [ 9.513468] systemd[1]: sshd-keygen.service: Deactivated successfully. machine # [ 9.515324] systemd[1]: Finished SSH Host Keys Generation. machine # [ 9.520052] systemd[1]: Starting SSH Daemon... sshClient # [ 9.636274] NET: Registered PF_PACKET protocol family sshClient # [ 9.505937] dhcpcd[683]: eth0: offered 10.0.2.15 from 10.0.2.2 sshClient # [ 9.508478] dhcpcd[683]: eth0: probing address 10.0.2.15/24 machine # [ 9.545131] sshd[747]: Server listening on 0.0.0.0 port 22. machine # [ 9.545937] systemd[1]: Started SSH Daemon. machine # [ 9.547199] sshd[747]: Server listening on :: port 22. machine # [ 9.568878] systemd-vconsole-setup[708]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 9.571843] systemd[1]: Finished Virtual Console Setup. sshClient # [ 9.965049] dhcpcd[683]: eth0: soliciting an IPv6 router sshClient # [ 9.966626] dhcpcd[683]: eth0: Router Advertisement from fe80::2 sshClient # [ 9.967523] dhcpcd[683]: eth0: adding address fec0::5054:ff:fe12:3456/64 sshClient # [ 9.968404] dhcpcd[683]: eth0: adding route to fec0::/64 sshClient # [ 9.969140] dhcpcd[683]: eth0: adding default route via fe80::2 machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.13 seconds) machine: sending keys 'foobarfoo\n' machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds) machine: waiting for (repeat) to appear on tty 1 machine # [ 10.855485] dhcpcd[698]: eth0: soliciting a DHCP lease machine # [ 10.877828] dhcpcd[698]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 10.880461] dhcpcd[698]: eth0: probing address 10.0.2.15/24 machine # [ 10.949584] dhcpcd[698]: eth0: soliciting an IPv6 router machine # [ 10.950714] dhcpcd[698]: eth0: Router Advertisement from fe80::2 machine # [ 10.951801] dhcpcd[698]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 10.952729] dhcpcd[698]: eth0: adding route to fec0::/64 machine # [ 10.953505] dhcpcd[698]: eth0: adding default route via fe80::2 machine: (finished: waiting for (repeat) to appear on tty 1, in 1.08 seconds) machine: sending keys 'foobarfoo\n' machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds) machine: waiting for unit systemd-homed-firstboot.service sshClient # [ 14.227208] dhcpcd[683]: eth0: leased 10.0.2.15 for 86400 seconds sshClient # [ 14.228121] dhcpcd[683]: eth0: adding route to 10.0.2.0/24 sshClient # [ 14.228869] dhcpcd[683]: eth0: adding default route via 10.0.2.2 sshClient # [ 14.294760] systemd[1]: Started DHCP Client. sshClient # [ 14.297929] systemd[1]: Reached target Multi-User System. sshClient # [ 14.299192] systemd[1]: Startup finished in 855ms (kernel) + 3.436s (initrd) + 10.007s (userspace) = 14.298s. machine # [ 16.092455] dhcpcd[698]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.093404] dhcpcd[698]: eth0: adding route to 10.0.2.0/24 machine # [ 16.094156] dhcpcd[698]: eth0: adding default route via 10.0.2.2 machine # [ 16.149306] systemd[1]: Started DHCP Client. machine # [ 22.001260] systemd-homed[518]: Generating key pair for signing local user identity records. machine # [ 22.005475] systemd-homed[518]: Successfully created Ed25519 key pair. machine # [ 22.022157] systemd-homed[518]: test-homed-user: changing state absent → creating machine # [ 22.083913] systemd-homework[872]: Using automatic default storage of 'luks'. machine # [ 22.087883] systemd-homework[872]: Sizing home to 83% of available disk space, which is 743M. machine # [ 22.089068] systemd-homework[872]: Allocating image file completed. machine # [ 22.106553] systemd-homework[872]: Writing of partition table completed. machine # [ 22.109454] systemd-homework[872]: Setting up loopback device /dev/loop0 completed. machine # [ 23.449620] systemd-homework[872]: LUKS formatting completed. machine # [ 25.217250] systemd-homework[872]: Writing password to LUKS keyslot 0 completed. machine # [ 25.393082] systemd-homework[872]: LUKS activation by volume key succeeded. machine # [ 25.406859] systemd-homework[872]: Writing user record as LUKS token completed. machine # [ 25.407880] systemd-homework[872]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 25.408997] systemd-homework[872]: Formatting /dev/mapper/home-test-homed-user as btrfs machine # [ 25.735140] systemd-homework[872]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid 41985bb3-ef17-4dc2-a18e-acd5967372eb) machine # [ 25.737039] systemd-homework[872]: Formatting file system completed. machine # [ 25.738340] systemd[1]: proc-903-mounts.mount: Deactivated successfully. machine # [ 25.768295] systemd-homework[872]: Mounting file system completed. machine # [ 25.771091] systemd-homework[872]: Skeleton directory /etc/skel missing, ignoring. machine # [ 25.772193] systemd-homework[872]: Wrote embedded .identity file. machine # [ 25.773325] systemd-homework[872]: Replaced embedded blob dir with contents of system blob dir. machine # [ 25.775493] systemd-homework[872]: Recursive changing of ownership completed. machine # [ 25.776753] systemd-homework[872]: Changed top-level directory access mode to 0700. machine # [ 25.798188] systemd-homework[872]: Synchronized disk. machine # [ 25.799420] systemd-homework[872]: Discarded unused 651.8M. machine # [ 25.808238] systemd-homed[518]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 25.817603] systemd-homed[518]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 25.838227] systemd-homework[872]: Moved image file into place. machine # [ 25.840057] systemd-homework[872]: Creation completed. machine # [ 25.840746] systemd-homework[872]: Image size is 743M, file system size is 725M, file system payload size is 725M, file system free is 718.9M. machine # [ 25.848664] systemd-homed[518]: test-homed-user: changing state creating → inactive machine # [ 25.854500] systemd[1]: Finished First Boot Home Area Wizard. machine # [ 25.856977] systemd[1]: systemd-mute-console@0-1-609_610-0.service: Deactivated successfully. machine # [ 25.860841] systemd[1]: Reached target First Boot Complete. machine # [ 25.864095] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 25.866293] systemd[1]: Starting Permit User Sessions... machine # [ 25.890494] systemd[1]: Finished Permit User Sessions. machine # [ 25.894746] systemd[1]: Started Getty on tty1. machine # [ 25.896772] systemd[1]: Reached target Login Prompts. machine # [ 25.898183] systemd[1]: Reached target Multi-User System. machine # [ 25.919155] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 25.921208] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 25.922951] systemd[1]: Startup finished in 827ms (kernel) + 4.337s (initrd) + 20.757s (userspace) = 25.922s. machine: (finished: waiting for unit systemd-homed-firstboot.service, in 14.63 seconds) (finished: subtest: create systemd-homed user on first boot prompt, in 27.17 seconds) machine: must succeed: homectl update test-homed-user --offline -G wheel machine # [ 26.520787] systemd-homed[518]: test-homed-user: changing state inactive → updating machine # [ 26.524838] systemd-homework[949]: Offline update requested. Not touching embedded records. machine # [ 26.526517] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 26.531780] systemd-homed[518]: test-homed-user: changing state updating → inactive machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.04 seconds) subtest: login as homed user machine: waiting for login: to appear on tty 1 machine: (finished: waiting for login: to appear on tty 1, in 0.02 seconds) machine: sending keys 'test-homed-user\n' machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds) machine: waiting for Password: to appear on tty 1 machine # [ 26.846967] systemd-homed[518]: block device /sys/devices/virtual/block/loop0 has been removed. machine # [ 26.882599] systemd-homed[518]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 26.886777] systemd-homework[964]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 26.941214] systemd-homed[518]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 26.943322] systemd-homed[518]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 26.947519] systemd-homed[518]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 26.950885] systemd-homed[518]: Home test-homed-user already deactivated, no automatic deactivation needed. machine: (finished: waiting for Password: to appear on tty 1, in 1.05 seconds) machine: sending keys 'foobarfoo\n' machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds) machine: waiting for success: pgrep -u test-homed-user -t tty1 bash machine # [ 27.957203] systemd-homed[518]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 27.989856] systemd-homework[976]: Provided password unlocks user record. machine # [ 27.993477] systemd-homework[976]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 27.998719] systemd-homework[976]: Allocated additional 651.8M. machine # [ 28.142976] loop1: detected capacity change from 0 to 1517568 machine # [ 28.004067] systemd-homework[976]: Setting up loopback device /dev/loop1 completed. machine # [ 28.823085] systemd-homework[976]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 28.846484] systemd-homework[976]: Provided password unlocks user record. machine # [ 28.851645] systemd-homework[976]: Probing file system completed (found btrfs). machine # [ 28.854270] systemd-homework[976]: No fsck for file system btrfs installed, ignoring. machine # [ 28.996651] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (976) machine # [ 28.999343] BTRFS info (device dm-0): first mount of filesystem 41985bb3-ef17-4dc2-a18e-acd5967372eb machine # [ 29.000404] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 29.003826] BTRFS info (device dm-0): enabling free space tree machine # [ 29.004454] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 28.864908] systemd-homework[976]: Mounting file system completed. machine # [ 28.866505] systemd-homework[976]: Discovered used loopback device /dev/loop1. machine # [ 28.867916] systemd-homework[976]: offset = 1048576, size = 776994816, image = 779091968 machine # [ 28.875211] systemd-homework[976]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M. machine # [ 28.876990] systemd-homework[976]: Growing of image file from 743M to 896M completed. machine # [ 29.021324] loop1: detected capacity change from 1517568 to 1830912 machine # [ 28.882489] systemd-homework[976]: Refreshing loop device size completed. machine # [ 28.894981] systemd-homework[976]: Growing of partition completed. machine # [ 29.048046] async_tx: api initialized (async) machine # [ 28.940237] systemd-homework[976]: LUKS device growing completed. machine # [ 29.089104] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 920649728 machine # [ 28.950926] systemd-homework[976]: File system resizing from 725M to 878M completed. machine # [ 28.953057] systemd-homework[976]: Synchronized disk. machine # [ 28.953740] systemd-homework[976]: Synchronized disk. machine # [ 28.954420] systemd-homework[976]: Resizing completed. machine # [ 28.955175] systemd-homework[976]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 28.956649] systemd-homework[976]: Read embedded .identity file. machine # [ 28.977300] systemd-homework[976]: Provided password unlocks user record. machine # [ 28.978790] systemd-homework[976]: Reconciling header user identity completed (host version was newer). machine # [ 28.979961] systemd-homework[976]: Reconciling embedded user identity completed (host version was newer). machine # [ 29.002726] systemd-homework[976]: Wrote LUKS header user record. machine # [ 29.003916] systemd-homework[976]: Wrote embedded .identity file. machine # [ 29.005390] systemd-homework[976]: Replaced embedded blob dir with contents of system blob dir. machine # [ 29.006926] systemd-homework[976]: Recursive changing of ownership not necessary, skipped. machine # [ 29.010511] systemd-homework[976]: Synchronized disk. machine # [ 29.012429] systemd-homework[976]: Moving to final mount point /home/test-homed-user completed. machine # [ 29.030959] systemd-homework[976]: Activation completed. machine # [ 29.031917] systemd-homework[976]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 29.042700] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 29.049114] login[940]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired. machine # [ 29.051061] systemd-homed[518]: test-homed-user: changing state activating-for-acquire → active machine # [ 29.057847] systemd-homed[518]: test-homed-user: changing state active → resizing-while-active machine # [ 29.069903] systemd-homework[1018]: Successfully acquired home volume key from kernel keyring. machine # [ 29.071474] systemd-homework[1018]: LUKS volume key from keyring unlocks user record. machine # [ 29.120432] login[940]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0) machine # [ 29.154284] systemd-homework[1018]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 29.170330] systemd[1]: Created slice Slice /user/60388. machine # [ 29.173235] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 29.188364] systemd-logind[547]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'. machine # [ 29.236387] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 29.251097] systemd[1]: Starting User Manager for UID 60388... machine # [ 29.298342] (systemd)[1023]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 29.347672] (systemd)[1023]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 29.353066] systemd-logind[547]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 29.416350] systemd[1023]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.431322] systemd-homework[1018]: Successfully re-activated LUKS device. machine # [ 29.433142] systemd-homework[1018]: LUKS volume key from keyring unlocks user record. machine # [ 29.434142] systemd-homework[1018]: Discovered used loopback device /dev/loop1. machine # [ 29.435081] systemd-homework[1018]: Read embedded .identity file. machine # [ 29.435838] systemd-homework[1018]: LUKS volume key from keyring unlocks user record. machine # [ 29.436786] systemd-homework[1018]: Reconciling header user identity completed (host version was newer). machine # [ 29.437924] systemd-homework[1018]: Reconciling embedded user identity completed (host version was newer). machine # [ 29.439090] systemd-homework[1018]: offset = 1048576, size = 937426944, image = 939524096 machine # [ 29.446402] systemd-homework[1018]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M. machine # [ 29.447910] systemd-homework[1018]: Wrote embedded .identity file. machine # [ 29.449406] systemd-homework[1018]: Replaced embedded blob dir with contents of system blob dir. machine # [ 29.452121] systemd-homework[1018]: Backing file is fully allocated already. machine # [ 29.597810] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 782237696 machine # [ 29.460176] systemd-homework[1018]: File system resizing from 878M to 746M completed. machine # [ 29.463065] systemd-homework[1018]: Synchronized disk. machine # [ 29.495489] systemd-homework[1018]: LUKS device shrinking completed. machine # [ 29.638389] loop1: detected capacity change from 1830912 to 1560576 machine # [ 29.500910] systemd-homework[1018]: Refreshing loop device size completed. machine # [ 29.502161] systemd-homework[1018]: Shrinking of image file completed. machine # [ 29.524317] systemd-homework[1018]: Shrinking of partition completed. machine # [ 29.542669] systemd-homework[1018]: Wrote LUKS header user record. machine # [ 29.543609] systemd-homework[1018]: Synchronized disk. machine # [ 29.546275] systemd-homework[1018]: Resizing completed. machine # [ 29.546982] systemd-homework[1018]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 29.561294] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 29.567866] systemd-homed[518]: test-homed-user: changing state resizing-while-active → active machine # [ 29.570073] systemd-homed[518]: Rebalancing complete. machine # [ 29.594073] systemd[1023]: Queued start job for default target Main User Target. machine # [ 29.596817] systemd[1023]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.603987] systemd[1023]: Created slice User Application Slice. machine # [ 29.604949] systemd[1023]: Started Daily Cleanup of User's Temporary Directories. machine # [ 29.606071] systemd[1023]: Reached target Paths. machine # [ 29.607345] systemd[1023]: Reached target Timers. machine # [ 29.609929] systemd[1023]: Starting D-Bus User Message Bus Socket... machine # [ 29.611807] systemd[1023]: Starting Create User Files and Directories... machine # [ 29.637064] systemd[1023]: Finished Create User Files and Directories. machine # [ 29.653450] systemd[1023]: Listening on D-Bus User Message Bus Socket. machine # [ 29.654389] systemd[1023]: Reached target Sockets. machine # [ 29.655062] systemd[1023]: Reached target Basic System. machine # [ 29.655788] systemd[1]: Started User Manager for UID 60388. machine # [ 29.659106] systemd[1023]: Starting Run user-specific NixOS activation... machine # [ 29.663651] systemd[1]: Started Session 1 of User test-homed-user. machine # [ 29.692185] systemd[1023]: Finished Run user-specific NixOS activation. machine # [ 29.693333] systemd[1023]: Reached target Main User Target. machine # [ 29.695135] systemd[1023]: Startup finished in 298ms. machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.18 seconds) machine: sending keys 'whoami > /tmp/2\n' machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.17 seconds) machine: waiting for file '/tmp/2' machine: (finished: waiting for file '/tmp/2', in 1.03 seconds) machine: must succeed: cat /tmp/2 machine: (finished: must succeed: cat /tmp/2, in 0.01 seconds) (finished: subtest: login as homed user, in 4.73 seconds) subtest: login as regular user sshClient: waiting for login: to appear on tty 1 sshClient: waiting for the VM to finish booting sshClient: Guest shell says: b'Spawning backdoor root shell...\n' sshClient: connected to guest root shell sshClient: (connecting took 0.00 seconds) sshClient: (finished: waiting for the VM to finish booting, in 0.00 seconds) sshClient: (finished: waiting for login: to appear on tty 1, in 0.06 seconds) sshClient: sending keys 'test-normal-user\n' sshClient: (finished: sending keys 'test-normal-user\n', in 0.18 seconds) sshClient: waiting for Password: to appear on tty 1 sshClient: (finished: waiting for Password: to appear on tty 1, in 1.08 seconds) sshClient: sending keys 'foobarfoo\n' sshClient: (finished: sending keys 'foobarfoo\n', in 0.10 seconds) sshClient: waiting for success: pgrep -u test-normal-user bash sshClient # [ 32.769591] login[692]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0) sshClient # [ 32.804425] systemd-logind[534]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'. sshClient # [ 32.815344] systemd[1]: Created slice Slice /user/1000. sshClient # [ 32.817313] systemd[1]: Starting User Runtime Directory /run/user/1000... sshClient # [ 32.860355] systemd[1]: Finished User Runtime Directory /run/user/1000. sshClient # [ 32.866903] systemd[1]: Starting User Manager for UID 1000... sshClient # [ 32.895858] (systemd)[814]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0) sshClient # [ 32.902487] systemd-logind[534]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'. sshClient # [ 32.920158] systemd[814]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 33.004901] systemd[814]: Queued start job for default target Main User Target. sshClient # [ 33.008843] systemd[814]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 33.011092] systemd[814]: Created slice User Application Slice. sshClient # [ 33.012043] systemd[814]: Started Daily Cleanup of User's Temporary Directories. sshClient # [ 33.014105] systemd[814]: Reached target Paths. sshClient # [ 33.014845] systemd[814]: Reached target Timers. sshClient # [ 33.016936] systemd[814]: Starting D-Bus User Message Bus Socket... sshClient # [ 33.018730] systemd[814]: Starting Create User Files and Directories... sshClient # [ 33.046950] systemd[814]: Finished Create User Files and Directories. sshClient # [ 33.064070] systemd[814]: Listening on D-Bus User Message Bus Socket. sshClient # [ 33.065021] systemd[814]: Reached target Sockets. sshClient # [ 33.065676] systemd[814]: Reached target Basic System. sshClient # [ 33.067101] systemd[1]: Started User Manager for UID 1000. sshClient # [ 33.069840] systemd[814]: Starting Run user-specific NixOS activation... sshClient # [ 33.073140] systemd[1]: Started Session 1 of User test-normal-user. sshClient # [ 33.108097] systemd[814]: Finished Run user-specific NixOS activation. sshClient # [ 33.109419] systemd[814]: Reached target Main User Target. sshClient # [ 33.110313] systemd[814]: Startup finished in 194ms. sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.05 seconds) sshClient: sending keys 'whoami > /tmp/1\n' sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.17 seconds) sshClient: waiting for file '/tmp/1' sshClient: (finished: waiting for file '/tmp/1', in 1.03 seconds) sshClient: must succeed: cat /tmp/1 sshClient: (finished: must succeed: cat /tmp/1, in 0.01 seconds) (finished: subtest: login as regular user, in 3.68 seconds) subtest: add homed ssh authorized key sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n' sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.49 seconds) sshClient: waiting for file '/tmp/id_ed25519.pub' sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.04 seconds) sshClient: must succeed: cat /tmp/id_ed25519.pub sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.02 seconds) machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIH4nqfMZcniORX3ZkaPXsCv2fPTrDRzwaA77FiqFCPIp test-normal-user@sshClient' machine # [ 36.529897] systemd-homed[518]: test-homed-user: changing state active → updating-while-active machine # [ 36.533398] systemd-homework[1073]: Offline update requested. Not touching embedded records. machine # [ 36.540779] systemd-homed[518]: test-homed-user: changing state updating-while-active → active machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIH4nqfMZcniORX3ZkaPXsCv2fPTrDRzwaA77FiqFCPIp test-normal-user@sshClient', in 0.03 seconds) machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519 machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.02 seconds) (finished: subtest: add homed ssh authorized key, in 1.61 seconds) subtest: change homed user password machine: sending keys 'passwd; echo $? > /tmp/3\n' machine: (finished: sending keys 'passwd; echo $? > /tmp/3\n', in 0.26 seconds) machine: waiting for New password: to appear on tty 1 machine: (finished: waiting for New password: to appear on tty 1, in 1.06 seconds) machine: sending keys 'barfoobar\n' machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds) machine: waiting for Retype new password: to appear on tty 1 machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.12 seconds) machine: sending keys 'barfoobar\n' machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds) ??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead. File "/nix/store/sriy4r0q27j8r84xmfnwwzc7q3jqgm4m-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 573 machine: must succeed: sleep 4.0 machine # [ 39.337394] systemd-homed[518]: test-homed-user: changing state active → passwd-while-active machine # [ 40.005351] systemd-homework[1112]: No valid password for LUKS superblock. machine # [ 42.349934] systemd-homed[518]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 42.352483] systemd-homed[518]: test-homed-user: changing state passwd-while-active → active machine: (finished: must succeed: sleep 4.0, in 4.03 seconds) machine: sending keys 'foobarfoo\n' machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds) machine: waiting for file '/tmp/3' machine # [ 43.469884] systemd-homed[518]: test-homed-user: changing state active → passwd-while-active machine # [ 44.765407] systemd-homework[1118]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 44.904096] systemd-homework[1118]: Successfully re-activated LUKS device. machine # [ 44.942584] systemd-homework[1118]: Provided password unlocks user record. machine # [ 44.944170] systemd-homework[1118]: Discovered used loopback device /dev/loop1. machine # [ 44.945155] systemd-homework[1118]: Read embedded .identity file. machine # [ 44.981635] systemd-homework[1118]: Provided password unlocks user record. machine # [ 44.983148] systemd-homework[1118]: Reconciling header user identity completed (host version was newer). machine # [ 44.984309] systemd-homework[1118]: Reconciling embedded user identity completed (host version was newer). machine # [ 47.987069] systemd-homework[1118]: Added LUKS key slot 1. machine # [ 48.016736] systemd-homework[1118]: Destroyed LUKS key slot 0. machine # [ 48.027341] systemd-homework[1118]: Wrote LUKS header user record. machine # [ 48.028501] systemd-homework[1118]: Wrote embedded .identity file. machine # [ 48.029666] systemd-homework[1118]: Replaced embedded blob dir with contents of system blob dir. machine # [ 48.036440] systemd-homework[1118]: Synchronized disk. machine # [ 48.041808] systemd-homework[1118]: Everything completed. machine # [ 48.050587] passwd[1086]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user. machine # [ 48.053535] systemd-homed[518]: test-homed-user: changing state passwd-while-active → active machine: (finished: waiting for file '/tmp/3', in 5.13 seconds) machine: must succeed: cat /tmp/3 machine: (finished: must succeed: cat /tmp/3, in 0.01 seconds) (finished: subtest: change homed user password, in 11.92 seconds) subtest: escalate to root from homed user machine: sending keys 'sudo id | tee /tmp/4\n' machine: (finished: sending keys 'sudo id | tee /tmp/4\n', in 0.22 seconds) machine: waiting for password for test-homed-user to appear on tty 1 machine # [ 48.928200] systemd-homed[518]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 48.931960] systemd-homework[1157]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 48.938495] systemd-homed[518]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 48.940590] systemd-homed[518]: test-homed-user: changing state authenticating-for-acquire → active machine: (finished: waiting for password for test-homed-user to appear on tty 1, in 1.07 seconds) machine: sending keys 'barfoobar\n' machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds) machine: waiting for file '/tmp/4' machine: (finished: waiting for file '/tmp/4', in 0.03 seconds) machine: waiting for success: grep uid=0 /tmp/4 machine # [ 49.961063] systemd-homed[518]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 49.999334] systemd-homework[1173]: Provided password unlocks user record. machine # [ 50.631105] systemd-homework[1173]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 50.759395] systemd-homework[1173]: Successfully re-activated LUKS device. machine # [ 50.779935] systemd-homework[1173]: Provided password unlocks user record. machine # [ 50.781319] systemd-homework[1173]: Discovered used loopback device /dev/loop1. machine # [ 50.782419] systemd-homework[1173]: Read embedded .identity file. machine # [ 50.800857] systemd-homework[1173]: Provided password unlocks user record. machine # [ 50.802383] systemd-homework[1173]: Reconciling user identities completed (host and header version were identical). machine # [ 50.803972] systemd-homework[1173]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 50.812803] systemd-homework[1173]: Everything completed. machine # [ 50.817589] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 50.824870] sudo[1155]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired. machine # [ 50.826603] systemd-homed[518]: test-homed-user: changing state authenticating-for-acquire → active machine # [ 50.831183] sudo[1155]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id machine # [ 50.841054] sudo[1155]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388) machine # [ 50.847953] sudo[1155]: pam_unix(sudo:session): session closed for user root machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.05 seconds) (finished: subtest: escalate to root from homed user, in 2.47 seconds) subtest: log out and deactivate homed user's home area machine: sending keys 'exit\n' machine: (finished: sending keys 'exit\n', in 0.05 seconds) machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive' machine # [ 51.036932] login[940]: pam_unix(login:session): session closed for user test-homed-user machine # [ 51.042635] login[940]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 51.051775] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 51.059670] systemd[1]: session-1.scope: Deactivated successfully. machine # [ 51.063752] systemd-logind[547]: Session 1 logged out. Waiting for processes to exit. machine # [ 51.067142] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. machine # [ 51.069967] systemd[1]: Started Getty on tty1. machine # [ 51.071483] systemd-logind[547]: Removed session 1. machine # [ 61.090381] systemd[1]: Stopping User Manager for UID 60388... machine # [ 61.094543] systemd[1023]: Activating special unit Exit the Session... machine # [ 61.096535] systemd[1023]: Stopped target Main User Target. machine # [ 61.098886] systemd[1023]: Stopped Run user-specific NixOS activation. machine # [ 61.101985] systemd[1023]: Stopped target Basic System. machine # [ 61.105919] systemd[1023]: Stopped target Paths. machine # [ 61.109798] systemd[1023]: Stopped target Sockets. machine # [ 61.114094] systemd[1023]: Stopped target Timers. machine # [ 61.116612] systemd[1023]: Stopped Daily Cleanup of User's Temporary Directories. machine # [ 61.119914] systemd[1023]: Closed D-Bus User Message Bus Socket. machine # [ 61.123996] systemd[1023]: Stopped Create User Files and Directories. machine # [ 61.126335] systemd[1023]: Removed slice User Application Slice. machine # [ 61.128289] systemd[1023]: Reached target Shutdown. machine # [ 61.129833] systemd[1023]: Finished Exit the Session. machine # [ 61.131459] systemd[1023]: Reached target Exit the Session. machine # [ 61.137267] systemd-logind[547]: Removed session 2. machine # [ 61.143356] systemd-homed[518]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 61.146258] systemd-homed[518]: test-homed-user: changing state active → deactivating machine # [ 61.147396] systemd[1]: user@60388.service: Deactivated successfully. machine # [ 61.149236] systemd[1]: Stopped User Manager for UID 60388. machine # [ 61.153664] systemd-homework[1251]: Successfully acquired home volume key from kernel keyring. machine # [ 61.156818] systemd-homework[1251]: Discarded unused 673.3M. machine # [ 61.170075] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully. machine # [ 61.174113] systemd-homework[1251]: Syncing completed. machine # [ 61.176692] systemd[1]: Stopping User Runtime Directory /run/user/60388... machine # [ 61.218136] systemd[1]: run-user-60388.mount: Deactivated successfully. machine # [ 61.221961] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully. machine # [ 61.224340] systemd[1]: Stopped User Runtime Directory /run/user/60388. machine # [ 61.235847] systemd-homework[1251]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 61.364397] systemd-homework[1251]: Successfully re-activated LUKS device. machine # [ 61.366162] systemd-homework[1251]: Discovered used loopback device /dev/loop1. machine # [ 61.367157] systemd-homework[1251]: offset = 1048576, size = 799014912, image = 801112064 machine # [ 61.379979] systemd-homework[1251]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M. machine # [ 61.382342] systemd-homework[1251]: Allocated additional 673.3M. machine # [ 61.529453] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 268435456 machine # [ 61.390630] systemd-homework[1251]: File system resizing from 746M to 256M completed. machine # [ 61.392199] systemd-homework[1251]: Synchronized disk. machine # [ 61.504743] systemd-homework[1251]: LUKS device shrinking completed. machine # [ 61.647262] loop1: detected capacity change from 1560576 to 557056 machine # [ 61.509208] systemd-homework[1251]: Refreshing loop device size completed. machine # [ 61.510183] systemd-homework[1251]: Shrinking of image file completed. machine # [ 61.525073] systemd-homework[1251]: Shrinking of partition completed. machine # [ 61.525962] systemd-homework[1251]: Synchronized disk. machine # [ 61.526659] systemd-homework[1251]: Resizing completed. machine # [ 61.527389] systemd-homework[1251]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M. machine # [ 61.669278] BTRFS info (device dm-0): last unmount of filesystem 41985bb3-ef17-4dc2-a18e-acd5967372eb machine # [ 61.532451] systemd-homework[1251]: Unmounting completed. machine # [ 61.533922] systemd-homework[1251]: Discovered used LUKS device /dev/mapper/home-test-homed-user. machine # [ 61.535278] systemd-homework[1251]: Device home-test-homed-user is not active. machine # [ 61.546087] systemd-homed[518]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 61.551598] systemd-homework[1251]: Everything completed. machine # [ 61.560273] systemd-homed[518]: test-homed-user: changing state deactivating → inactive machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 11.50 seconds) (finished: subtest: log out and deactivate homed user's home area, in 11.55 seconds) subtest: ssh as homed user sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n' sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.78 seconds) sshClient: waiting for Please enter password for user to appear on tty 1 machine # [ 64.264687] systemd-homed[518]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 64.268810] systemd-homework[1285]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 64.274736] systemd-homed[518]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 64.276893] sshd-session[1281]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error machine # [ 64.278394] systemd-homed[518]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 64.279491] systemd-homed[518]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 64.282137] sshd-session[1281]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation. machine # [ 64.283892] sshd-session[1281]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 58308 ssh2: ED25519 SHA256:6Ov4P6CkEtpWXVMLh4a57m8JIsZmZjT8jq29JxChR8I machine # [ 64.323202] sshd-session[1281]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 64.339242] systemd-logind[547]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'. machine # [ 64.342330] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 64.362152] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 64.367470] systemd[1]: Started Session 3 of User test-homed-user. machine # [ 64.383599] sshd-session[1281]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 64.386410] sshd-session[1281]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 64.399934] systemd-homed[518]: test-homed-user: changing state inactive → activating machine # [ 64.403553] systemd-homework[1293]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 64.442229] systemd-homed[518]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 64.444288] systemd-homed[518]: test-homed-user: changing state activating → inactive sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.09 seconds) sshClient: sending keys 'barfoobar\n' sshClient: (finished: sending keys 'barfoobar\n', in 0.10 seconds) machine: waiting for success: pgrep -u test-homed-user bash machine # [ 65.571780] systemd-homed[518]: test-homed-user: changing state inactive → activating machine # [ 65.617788] systemd-homework[1298]: Provided password unlocks user record. machine # [ 65.622411] systemd-homework[1298]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 65.627665] systemd-homework[1298]: Backing file is fully allocated already. machine # [ 65.772146] loop1: detected capacity change from 0 to 557056 machine # [ 65.633520] systemd-homework[1298]: Setting up loopback device /dev/loop1 completed. machine # [ 66.635407] systemd-homework[1298]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 66.660935] systemd-homework[1298]: Provided password unlocks user record. machine # [ 66.666252] systemd-homework[1298]: Probing file system completed (found btrfs). machine # [ 66.667656] systemd-homework[1298]: No fsck for file system btrfs installed, ignoring. machine # [ 66.809581] BTRFS: device label test-homed-user devid 1 transid 17 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1298) machine # [ 66.812369] BTRFS info (device dm-0): first mount of filesystem 41985bb3-ef17-4dc2-a18e-acd5967372eb machine # [ 66.813344] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 66.817619] BTRFS info (device dm-0): enabling free space tree machine # [ 66.818261] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 66.678849] systemd-homework[1298]: Mounting file system completed. machine # [ 66.680723] systemd-homework[1298]: Discovered used loopback device /dev/loop1. machine # [ 66.681714] systemd-homework[1298]: offset = 1048576, size = 285212672, image = 287309824 machine # [ 66.691956] systemd-homework[1298]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M. machine # [ 66.693962] systemd-homework[1298]: Growing of image file from 274M to 764M completed. machine # [ 66.837151] loop1: detected capacity change from 557056 to 1560576 machine # [ 66.698130] systemd-homework[1298]: Refreshing loop device size completed. machine # [ 66.713459] systemd-homework[1298]: Growing of partition completed. machine # [ 66.742286] systemd-homework[1298]: LUKS device growing completed. machine # [ 66.889980] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 782237696 machine # [ 66.752058] systemd-homework[1298]: File system resizing from 256M to 746M completed. machine # [ 66.753071] systemd-homework[1298]: Synchronized disk. machine # [ 66.753735] systemd-homework[1298]: Synchronized disk. machine # [ 66.754476] systemd-homework[1298]: Resizing completed. machine # [ 66.755209] systemd-homework[1298]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 66.756730] systemd-homework[1298]: Read embedded .identity file. machine # [ 66.775287] systemd-homework[1298]: Provided password unlocks user record. machine # [ 66.776825] systemd-homework[1298]: Reconciling user identities completed (host and header version were identical). machine # [ 66.778207] systemd-homework[1298]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 66.779867] systemd-homework[1298]: Recursive changing of ownership not necessary, skipped. machine # [ 66.781049] systemd-homework[1298]: Synchronized disk. machine # [ 66.783174] systemd-homework[1298]: Moving to final mount point /home/test-homed-user completed. machine # [ 66.805059] systemd-homework[1298]: Activation completed. machine # [ 66.806181] systemd-homework[1298]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 66.818709] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 66.826493] systemd-homed[518]: test-homed-user: changing state activating → active machine # [ 66.836222] systemd[1]: Starting User Manager for UID 60388... machine # [ 66.858759] (systemd)[1340]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 66.896184] (systemd)[1340]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 66.901538] systemd-logind[547]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 66.918083] systemd[1340]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.993865] systemd[1340]: Queued start job for default target Main User Target. machine # [ 66.996683] systemd[1340]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.999180] systemd[1340]: Created slice User Application Slice. machine # [ 67.001057] systemd[1340]: Started Daily Cleanup of User's Temporary Directories. machine # [ 67.001991] systemd[1340]: Reached target Paths. machine # [ 67.002671] systemd[1340]: Reached target Timers. machine # [ 67.004965] systemd[1340]: Starting D-Bus User Message Bus Socket... machine # [ 67.006809] systemd[1340]: Starting Create User Files and Directories... machine # [ 67.034110] systemd[1340]: Finished Create User Files and Directories. machine # [ 67.034972] systemd[1340]: Listening on D-Bus User Message Bus Socket. machine # [ 67.036668] systemd[1340]: Reached target Sockets. machine # [ 67.038594] systemd[1340]: Reached target Basic System. machine # [ 67.039369] systemd[1]: Started User Manager for UID 60388. machine # [ 67.042324] systemd[1340]: Starting Run user-specific NixOS activation... machine # [ 67.076099] systemd[1340]: Finished Run user-specific NixOS activation. machine # [ 67.077333] systemd[1340]: Reached target Main User Target. machine # [ 67.079124] systemd[1340]: Startup finished in 165ms. machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.16 seconds) sshClient: sending keys 'whoami > /tmp/5\n' sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.17 seconds) machine: waiting for file '/tmp/5' machine: (finished: waiting for file '/tmp/5', in 1.06 seconds) machine: must succeed: cat /tmp/5 machine: (finished: must succeed: cat /tmp/5, in 0.03 seconds) sshClient: sending keys 'exit\n' sshClient: (finished: sending keys 'exit\n', in 0.05 seconds) sshClient: sending keys 'exit\n' sshClient: (finished: sending keys 'exit\n', in 0.05 seconds) (finished: subtest: ssh as homed user, in 6.48 seconds) (finished: run the VM test script, in 69.91 seconds) machine # [ 68.985352] sshd-session[1290]: Received disconnect from 2001:db8:1::2 port 58308:11: disconnected by user machine # [ 68.990670] sshd-session[1290]: Disconnected from user test-homed-user 2001:db8:1::2 port 58308 machine # [ 68.997991] sshd-session[1281]: pam_unix(sshd:session): session closed for user test-homed-user machine # [ 69.004477] sshd-session[1281]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 69.015627] systemd[1]: session-3.scope: Deactivated successfully. machine # [ 69.026535] systemd-logind[547]: Session 3 logged out. Waiting for processes to exit. machine # [ 69.031933] systemd-logind[547]: Removed session 3. test script finished in 70.06s cleanup kill QemuMachine (pid 47) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14) machine # [2026-09-22T03:04:21Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-22T03:04:21Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-22T03:04:21Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 48) sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14) sshClient # [2026-09-22T03:04:21Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-09-22T03:04:21Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-09-22T03:04:21Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.41 seconds) additionally exposed symbols: machine, sshClient, 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