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.01 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 machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.D73t8cKMEn', fmt=raw size=1073741824 machine: QEMU running (pid 48) 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: 4c4695af-b89c-4454-ad86-57559ecf35bf 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 # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-18T02:49:34Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-18T02:49:34Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-18T02:49:34Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-18T02:49:34Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-18T02:49:34Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-18T02:49:34Z INFO virtiofsd] Client connected, servicing requests sshClient # Disk image does not exist, creating the virtualisation disk image... sshClient: QEMU running (pid 47) sshClient # Formatting '/build/vm-state-sshClient/tmp.IkKLSKvx3e', fmt=raw size=1073741824 sshClient # mke2fs 1.47.4 (6-Mar-2025) (finished: start all VMs, in 0.78 seconds) sshClient # Discarding device blocks: 0/262144 done subtest: create systemd-homed user on first boot prompt sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes machine: waiting for unit systemd-homed.service sshClient # Filesystem UUID: 6e0dbe1f-8f21-476e-af1d-7072c9cb10a2 machine: waiting for the VM to finish booting 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-10-18T02:49:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-18T02:49:34Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-18T02:49:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-18T02:49:34Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-18T02:49:34Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-18T02:49:34Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-10-18T02:49:34Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-10-18T02:49:34Z INFO virtiofsd] Client connected, servicing requests machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) 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 # 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 # machine # Booting from ROM... 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 # sshClient # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 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/2mw85zxm6chfqxq53kkyc89z8pghlih4-nixos-system-machine-test/init regInfo=/nix/.ro-store/mna80rkgdd3blrqyvxi30ymiz8vfkf1i-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 438830444 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000004] tsc: Detected 2400.008 MHz processor machine # [ 0.000765] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000791] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000794] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002686] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002698] Using GB pages for direct mapping machine # [ 0.002788] RAMDISK: [mem 0x3e2af000-0x3ffcffff] machine # [ 0.002795] ACPI: Early table checksum verification disabled machine # [ 0.002798] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002802] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002807] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002814] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002816] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002818] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002819] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002821] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002822] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002824] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002825] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002825] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002826] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002826] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002827] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002827] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003049] No NUMA configuration found machine # [ 0.003050] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003053] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005140] Zone ranges: machine # [ 0.005140] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005142] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005143] Normal empty machine # [ 0.005144] Device empty machine # [ 0.005144] Movable zone start for each node machine # [ 0.005145] Early memory node ranges machine # [ 0.005145] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005146] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005147] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005168] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005580] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.022183] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.022636] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.022646] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.022675] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.022678] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.022679] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.022680] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.022681] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.022682] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.022685] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.022686] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.022688] TSC deadline timer available machine # [ 0.022692] CPU topo: Max. logical packages: 1 machine # [ 0.022693] CPU topo: Max. logical dies: 1 machine # [ 0.022693] CPU topo: Max. dies per package: 1 machine # [ 0.022696] CPU topo: Max. threads per core: 1 machine # [ 0.022697] CPU topo: Num. cores per package: 1 machine # [ 0.022698] CPU topo: Num. threads per package: 1 machine # [ 0.022698] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.022714] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.022746] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.022747] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.022748] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.022750] Booting paravirtualized kernel on KVM machine # [ 0.022752] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.027444] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.029509] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.029551] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.029553] 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/2mw85zxm6chfqxq53kkyc89z8pghlih4-nixos-system-machine-test/init regInfo=/nix/.ro-store/mna80rkgdd3blrqyvxi30ymiz8vfkf1i-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.029644] Unknown kernel command line parameters "regInfo=/nix/.ro-store/mna80rkgdd3blrqyvxi30ymiz8vfkf1i-closure-info/registration", will be passed to user space. machine # [ 0.029656] random: crng init done machine # [ 0.029657] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.029678] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.030182] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.030211] Fallback order for Node 0: 0 machine # [ 0.030214] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.030215] Policy zone: DMA32 machine # [ 0.032239] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.034597] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.036693] allocated 2097152 bytes of page_ext machine # [ 0.046414] ftrace: allocating 48842 entries in 192 pages machine # [ 0.046416] ftrace: allocated 192 pages with 2 groups machine # [ 0.047211] Dynamic Preempt: lazy machine # [ 0.047343] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.047344] rcu: RCU event tracing is enabled. machine # [ 0.047344] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. machine # [ 0.047346] Trampoline variant of Tasks RCU enabled. machine # [ 0.047347] Rude variant of Tasks RCU enabled. machine # [ 0.047347] Tracing variant of Tasks RCU enabled. machine # [ 0.047348] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.047349] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 sshClient # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 machine # [ 0.047395] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.047397] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.047398] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051647] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.051917] rcu: srcu_init: Setting srcu_struct sizes based on contention. 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/cv1vh5fjx6vaaw2dclpi2ifdsi00y2l4-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/0n21llhgwwsv9001g3yi97dz9czaf1ls-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.051923] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.052016] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.055493] Console: colour VGA+ 80x25 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.055496] printk: legacy console [tty0] enabled sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.084842] printk: legacy console [ttyS0] enabled sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.191692] ACPI: Core revision 20250807 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.192590] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.194201] APIC: Switch to symmetric I/O mode setup machine # [ 0.195192] x2apic enabled sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.195993] APIC: Switched APIC routing to: physical x2apic sshClient # [ 0.000000] NX (Execute Disable) protection: active sshClient # [ 0.000000] APIC: Static calls initialized sshClient # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.197914] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 sshClient # [ 0.000000] DMI: Memory slots populated: 1/1 sshClient # [ 0.000000] Hypervisor detected: KVM machine # [ 0.198909] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.200635] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) sshClient # [ 0.000000] kvm-clock: using sched offset of 510124638 cycles machine # [ 0.201718] x86/cpu: User Mode Instruction Prevention (UMIP) activated sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.203690] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 sshClient # [ 0.000005] tsc: Detected 2400.008 MHz processor machine # [ 0.204612] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 sshClient # [ 0.000767] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 sshClient # [ 0.000794] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.205635] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto sshClient # [ 0.000797] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT sshClient # [ 0.002685] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.206632] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl sshClient # [ 0.002695] Using GB pages for direct mapping sshClient # [ 0.002815] RAMDISK: [mem 0x3e2b5000-0x3ffcffff] machine # [ 0.208632] Transient Scheduler Attacks: Vulnerable: No microcode sshClient # [ 0.002822] ACPI: Early table checksum verification disabled machine # [ 0.209631] Spectre V2 : Mitigation: Enhanced / Automatic IBRS sshClient # [ 0.002825] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.210632] Speculative Return Stack Overflow: Mitigation: Safe RET sshClient # [ 0.002829] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002833] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002841] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002843] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.211631] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization sshClient # [ 0.002844] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.213639] Spectre V2 : Enabling IBPB for BPF sshClient # [ 0.002846] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002847] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.214382] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier sshClient # [ 0.002849] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.215632] active return thunk: srso_alias_return_thunk sshClient # [ 0.002850] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.216652] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' sshClient # [ 0.002851] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.218631] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.002852] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] sshClient # [ 0.002852] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.219631] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' sshClient # [ 0.002853] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.220632] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' sshClient # [ 0.002853] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.221631] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' sshClient # [ 0.002854] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.222631] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' sshClient # [ 0.003079] No NUMA configuration found sshClient # [ 0.003080] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.223632] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' sshClient # [ 0.003082] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] sshClient # [ 0.005179] Zone ranges: machine # [ 0.224632] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 sshClient # [ 0.005180] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.225631] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 sshClient # [ 0.005181] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] sshClient # [ 0.005182] Normal empty sshClient # [ 0.005183] Device empty machine # [ 0.226632] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 sshClient # [ 0.005184] Movable zone start for each node machine # [ 0.227631] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 sshClient # [ 0.005185] Early memory node ranges sshClient # [ 0.005185] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.228631] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 sshClient # [ 0.005186] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] sshClient # [ 0.005187] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.229631] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. sshClient # [ 0.005205] On node 0, zone DMA: 1 pages in unavailable ranges sshClient # [ 0.005451] On node 0, zone DMA: 97 pages in unavailable ranges sshClient # [ 0.022202] On node 0, zone DMA32: 40 pages in unavailable ranges sshClient # [ 0.022645] ACPI: PM-Timer IO Port: 0x608 sshClient # [ 0.022655] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) sshClient # [ 0.022681] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 sshClient # [ 0.022684] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) sshClient # [ 0.022686] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) sshClient # [ 0.022687] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) sshClient # [ 0.022688] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) sshClient # [ 0.022688] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) sshClient # [ 0.022691] ACPI: Using ACPI (MADT) for SMP configuration information sshClient # [ 0.022692] ACPI: HPET id: 0x8086a201 base: 0xfed00000 sshClient # [ 0.022694] TSC deadline timer available sshClient # [ 0.022698] CPU topo: Max. logical packages: 1 sshClient # [ 0.022699] CPU topo: Max. logical dies: 1 sshClient # [ 0.022699] CPU topo: Max. dies per package: 1 sshClient # [ 0.022703] CPU topo: Max. threads per core: 1 sshClient # [ 0.022703] CPU topo: Num. cores per package: 1 sshClient # [ 0.022704] CPU topo: Num. threads per package: 1 sshClient # [ 0.022704] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs sshClient # [ 0.022721] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() sshClient # [ 0.022747] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] sshClient # [ 0.022749] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] sshClient # [ 0.022750] [mem 0x40000000-0xafffffff] available for PCI devices sshClient # [ 0.022751] Booting paravirtualized kernel on KVM sshClient # [ 0.022754] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns sshClient # [ 0.027389] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 sshClient # [ 0.029521] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 sshClient # [ 0.029565] kvm-guest: PV spinlocks disabled, single CPU sshClient # [ 0.029566] 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/cv1vh5fjx6vaaw2dclpi2ifdsi00y2l4-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/0n21llhgwwsv9001g3yi97dz9czaf1ls-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.029656] Unknown kernel command line parameters "regInfo=/nix/.ro-store/0n21llhgwwsv9001g3yi97dz9czaf1ls-closure-info/registration", will be passed to user space. sshClient # [ 0.029667] random: crng init done sshClient # [ 0.029668] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes sshClient # [ 0.029689] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.263473] Freeing SMP alternatives memory: 48K sshClient # [ 0.030207] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.264199] pid_max: default: 32768 minimum: 301 sshClient # [ 0.030235] Fallback order for Node 0: 0 sshClient # [ 0.030238] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.264723] LSM: initializing lsm=capability,landlock,yama,bpf,ima sshClient # [ 0.030239] Policy zone: DMA32 machine # [ 0.265726] landlock: Up and running. sshClient # [ 0.032642] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.266632] Yama: becoming mindful. sshClient # [ 0.035072] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.267662] LSM support for eBPF active sshClient # [ 0.037340] allocated 2097152 bytes of page_ext sshClient # [ 0.046942] ftrace: allocating 48842 entries in 192 pages machine # [ 0.268392] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.046945] ftrace: allocated 192 pages with 2 groups sshClient # [ 0.047756] Dynamic Preempt: lazy sshClient # [ 0.047883] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.269650] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.047884] rcu: RCU event tracing is enabled. sshClient # [ 0.047884] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. sshClient # [ 0.047886] Trampoline variant of Tasks RCU enabled. machine # [ 0.271915] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) sshClient # [ 0.047886] Rude variant of Tasks RCU enabled. sshClient # [ 0.047887] Tracing variant of Tasks RCU enabled. machine # [ 0.273171] Performance Events: Fam17h+ core perfctr, AMD PMU driver. sshClient # [ 0.047887] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.273641] ... version: 2 sshClient # [ 0.047888] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.274352] ... bit width: 48 sshClient # [ 0.047942] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.274634] ... generic counters: 6 machine # [ 0.275378] ... generic bitmap: 000000000000003f sshClient # [ 0.047944] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.275634] ... fixed-purpose counters: 0 sshClient # [ 0.047945] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.276350] ... fixed-purpose bitmap: 0000000000000000 sshClient # [ 0.052195] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.276634] ... value mask: 0000ffffffffffff sshClient # [ 0.052468] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.277525] ... max period: 00007fffffffffff sshClient # [ 0.052473] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.278327] ... global_ctrl mask: 000000000000003f machine # [ 0.278727] signal: max sigframe size: 3376 sshClient # [ 0.052572] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) sshClient # [ 0.056103] Console: colour VGA+ 80x25 machine # [ 0.279515] rcu: Hierarchical SRCU implementation. sshClient # [ 0.056106] printk: legacy console [tty0] enabled machine # [ 0.280251] rcu: Max phase no-delay instances is 400. sshClient # [ 0.085509] printk: legacy console [ttyS0] enabled sshClient # [ 0.190589] ACPI: Core revision 20250807 sshClient # [ 0.191534] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.193143] APIC: Switch to symmetric I/O mode setup sshClient # [ 0.194215] x2apic enabled machine # [ 0.285133] smp: Bringing up secondary CPUs ... sshClient # [ 0.194961] APIC: Switched APIC routing to: physical x2apic machine # [ 0.285648] smp: Brought up 1 node, 1 CPU machine # [ 0.286346] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) sshClient # [ 0.196812] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 sshClient # [ 0.197836] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.286848] Memory: 940328K/1048024K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 100348K reserved, 0K cma-reserved) machine # [ 0.287862] devtmpfs: initialized sshClient # [ 0.199539] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) machine # [ 0.288673] x86/mm: Memory block size: 128MB sshClient # [ 0.200623] x86/cpu: User Mode Instruction Prevention (UMIP) activated sshClient # [ 0.202625] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.290387] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.203536] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.291604] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.292729] pinctrl core: initialized pinctrl subsystem sshClient # [ 0.204540] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.293833] PM: RTC time: 02:49:34, date: 2026-10-18 sshClient # [ 0.205537] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl sshClient # [ 0.206537] Transient Scheduler Attacks: Vulnerable: No microcode sshClient # [ 0.207536] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.297216] NET: Registered PF_NETLINK/PF_ROUTE protocol family sshClient # [ 0.208536] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.297974] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.298656] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations sshClient # [ 0.209536] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.299771] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations sshClient # [ 0.211543] Spectre V2 : Enabling IBPB for BPF machine # [ 0.300644] audit: initializing netlink subsys (disabled) sshClient # [ 0.213084] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.301838] thermal_sys: Registered thermal governor 'fair_share' sshClient # [ 0.213537] active return thunk: srso_alias_return_thunk machine # [ 0.301840] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.302635] thermal_sys: Registered thermal governor 'step_wise' sshClient # [ 0.214558] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.303623] thermal_sys: Registered thermal governor 'user_space' sshClient # [ 0.215536] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.216536] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.304430] audit: type=2000 audit(1792291775.530:1): state=initialized audit_enabled=0 res=1 sshClient # [ 0.217536] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.306637] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.306652] cpuidle: using governor menu sshClient # [ 0.218536] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' sshClient # [ 0.219536] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.308884] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 sshClient # [ 0.220536] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.309850] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] sshClient # [ 0.221536] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.310637] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry sshClient # [ 0.223300] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.311646] PCI: Using configuration type 1 for base access sshClient # [ 0.224536] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 sshClient # [ 0.225536] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.312758] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. sshClient # [ 0.226536] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 sshClient # [ 0.227536] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.317869] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.318635] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.323635] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.324634] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.334965] ACPI: Added _OSI(Module Device) machine # [ 0.335636] ACPI: Added _OSI(Processor Device) machine # [ 0.336407] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.344821] ACPI: 1 ACPI AML tables successfully acquired and loaded sshClient # [ 0.261341] Freeing SMP alternatives memory: 48K sshClient # [ 0.262213] pid_max: default: 32768 minimum: 301 sshClient # [ 0.262628] LSM: initializing lsm=capability,landlock,yama,bpf,ima sshClient # [ 0.263638] landlock: Up and running. machine # [ 0.349050] ACPI: Interpreter enabled sshClient # [ 0.265010] Yama: becoming mindful. machine # [ 0.349651] ACPI: PM: (supports S0 S3 S4 S5) sshClient # [ 0.265752] LSM support for eBPF active machine # [ 0.350372] ACPI: Using IOAPIC for interrupt routing sshClient # [ 0.266612] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.350683] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug sshClient # [ 0.267556] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.351635] PCI: Using E820 reservations for host bridge windows sshClient # [ 0.270220] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.354762] ACPI: Enabled 2 GPEs in block 00 to 3F sshClient # [ 0.271047] Performance Events: Fam17h+ core perfctr, AMD PMU driver. sshClient # [ 0.271542] ... version: 2 sshClient # [ 0.272267] ... bit width: 48 sshClient # [ 0.272539] ... generic counters: 6 sshClient # [ 0.273306] ... generic bitmap: 000000000000003f sshClient # [ 0.273550] ... fixed-purpose counters: 0 sshClient # [ 0.274284] ... fixed-purpose bitmap: 0000000000000000 sshClient # [ 0.274539] ... value mask: 0000ffffffffffff sshClient # [ 0.275538] ... max period: 00007fffffffffff machine # [ 0.362875] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) sshClient # [ 0.276462] ... global_ctrl mask: 000000000000003f sshClient # [ 0.277363] signal: max sigframe size: 3376 machine # [ 0.363641] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] sshClient # [ 0.278135] rcu: Hierarchical SRCU implementation. sshClient # [ 0.278543] rcu: Max phase no-delay instances is 400. machine # [ 0.364711] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.365756] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.367034] PCI host bridge to bus 0000:00 machine # [ 0.367639] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.368634] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] sshClient # [ 0.283942] smp: Bringing up secondary CPUs ... machine # [ 0.369634] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] sshClient # [ 0.284553] smp: Brought up 1 node, 1 CPU machine # [ 0.370634] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] sshClient # [ 0.285273] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) machine # [ 0.371634] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.285708] Memory: 940300K/1048024K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 100324K reserved, 0K cma-reserved) machine # [ 0.372634] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.286926] devtmpfs: initialized machine # [ 0.373635] pci_bus 0000:00: root bus resource [bus 00-ff] sshClient # [ 0.287756] x86/mm: Memory block size: 128MB machine # [ 0.374697] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint sshClient # [ 0.289400] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.376124] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint sshClient # [ 0.290476] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). sshClient # [ 0.291623] pinctrl core: initialized pinctrl subsystem sshClient # [ 0.292816] PM: RTC time: 02:49:34, date: 2026-10-18 sshClient # [ 0.296130] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.378674] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.379714] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] sshClient # [ 0.296886] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.380701] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] sshClient # [ 0.297555] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations sshClient # [ 0.298677] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.381951] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] sshClient # [ 0.299548] audit: initializing netlink subsys (disabled) sshClient # [ 0.300737] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.383371] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.300739] thermal_sys: Registered thermal governor 'bang_bang' sshClient # [ 0.301540] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.385675] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] sshClient # [ 0.302543] audit: type=2000 audit(1792291775.627:1): state=initialized audit_enabled=0 res=1 machine # [ 0.386586] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] sshClient # [ 0.304542] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.387455] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] sshClient # [ 0.304543] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.388520] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] sshClient # [ 0.305547] cpuidle: using governor menu sshClient # [ 0.307778] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.389982] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.308764] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] sshClient # [ 0.309542] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.391672] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] sshClient # [ 0.310551] PCI: Using configuration type 1 for base access machine # [ 0.392573] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] sshClient # [ 0.311680] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.393504] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.395119] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.397674] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.398643] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] sshClient # [ 0.318817] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.399594] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] sshClient # [ 0.319540] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.401023] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.402671] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.403489] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] sshClient # [ 0.324540] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.404343] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] sshClient # [ 0.325540] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.404641] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.406651] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.408681] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.409656] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.411167] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.334174] ACPI: Added _OSI(Module Device) sshClient # [ 0.334541] ACPI: Added _OSI(Processor Device) sshClient # [ 0.335354] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.412647] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.413658] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.415229] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.416636] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.417634] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.419216] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.344830] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.420679] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.421656] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] sshClient # [ 0.348977] ACPI: Interpreter enabled sshClient # [ 0.349554] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.423163] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint sshClient # [ 0.350283] ACPI: Using IOAPIC for interrupt routing sshClient # [ 0.350602] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.424682] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] sshClient # [ 0.351539] PCI: Using E820 reservations for host bridge windows machine # [ 0.425552] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.426391] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] sshClient # [ 0.354676] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.427176] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.428889] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.429642] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.430655] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.432218] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.362063] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) sshClient # [ 0.362545] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.433342] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] sshClient # [ 0.363614] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.433838] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.364660] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.435245] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] sshClient # [ 0.365885] PCI host bridge to bus 0000:00 sshClient # [ 0.366544] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.435825] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.367539] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.437326] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] sshClient # [ 0.368539] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] sshClient # [ 0.369539] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] sshClient # [ 0.370538] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.371539] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.372539] pci_bus 0000:00: root bus resource [bus 00-ff] sshClient # [ 0.373594] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint sshClient # [ 0.374978] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.437850] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.440263] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.440901] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint sshClient # [ 0.377567] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] sshClient # [ 0.378621] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.441919] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO sshClient # [ 0.379606] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.443105] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint sshClient # [ 0.380854] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.444664] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] sshClient # [ 0.382270] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.445641] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.447005] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint sshClient # [ 0.384572] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] sshClient # [ 0.385545] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.448455] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] sshClient # [ 0.386544] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] sshClient # [ 0.387544] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] sshClient # [ 0.389126] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.453095] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.453740] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 sshClient # [ 0.390572] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.454736] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 sshClient # [ 0.391461] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.455734] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 sshClient # [ 0.392334] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.456736] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.457731] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 sshClient # [ 0.394069] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.458737] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.459749] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.460673] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.461648] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.396758] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.462654] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 sshClient # [ 0.397545] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.463649] ACPI: PCI: Interrupt link GSID configured for IRQ 19 sshClient # [ 0.398554] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.464649] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.465647] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 sshClient # [ 0.400125] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.466650] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.467647] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.401572] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] sshClient # [ 0.402424] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.469733] iommu: Default domain type: Translated sshClient # [ 0.403322] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.470642] iommu: DMA domain TLB invalidation policy: lazy mode sshClient # [ 0.404439] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.471881] ACPI: bus type USB registered machine # [ 0.472642] usbcore: registered new interface driver usbfs sshClient # [ 0.406089] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.473547] usbcore: registered new interface driver hub machine # [ 0.474294] usbcore: registered new device driver usb sshClient # [ 0.407369] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.475545] NetLabel: Initializing sshClient # [ 0.408343] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.476099] NetLabel: domain hash size = 128 machine # [ 0.476634] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO sshClient # [ 0.410056] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.477600] NetLabel: unlabeled traffic allowed by default machine # [ 0.478351] PCI: Using ACPI for IRQ routing sshClient # [ 0.411552] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] sshClient # [ 0.412561] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] sshClient # [ 0.414129] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.415358] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] sshClient # [ 0.416387] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] sshClient # [ 0.417999] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.419540] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] sshClient # [ 0.420562] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] sshClient # [ 0.422078] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint sshClient # [ 0.423591] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] sshClient # [ 0.424524] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] sshClient # [ 0.425363] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] sshClient # [ 0.427041] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.429220] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] sshClient # [ 0.429546] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] sshClient # [ 0.430560] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] sshClient # [ 0.432129] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.433118] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] sshClient # [ 0.433773] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.435099] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] sshClient # [ 0.435733] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.437053] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.521712] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.522630] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.522630] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.522639] vgaarb: loaded machine # [ 0.523420] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 sshClient # [ 0.437757] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.523636] hpet0: 3 comparators, 64-bit 100.000000 MHz counter sshClient # [ 0.440039] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] sshClient # [ 0.440809] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint sshClient # [ 0.441822] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.527727] clocksource: Switched to clocksource kvm-clock sshClient # [ 0.442795] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint sshClient # [ 0.444506] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.531602] VFS: Disk quotas dquot_6.6.0 sshClient # [ 0.445280] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.532505] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.533934] pnp: PnP ACPI init sshClient # [ 0.445874] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.534848] ACPI: IRQ 4 override to edge(!), high(!) sshClient # [ 0.447171] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.535844] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.537487] pnp: PnP ACPI: found 5 devices sshClient # [ 0.451141] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 sshClient # [ 0.451657] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 sshClient # [ 0.452638] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 sshClient # [ 0.453648] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 sshClient # [ 0.454637] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.545198] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns sshClient # [ 0.455644] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.546725] clocksource: Switched to clocksource acpi_pm machine # [ 0.547744] NET: Registered PF_INET protocol family machine # [ 0.548860] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) sshClient # [ 0.457535] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 sshClient # [ 0.458677] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 sshClient # [ 0.459578] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 sshClient # [ 0.460558] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.461555] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 sshClient # [ 0.462554] ACPI: PCI: Interrupt link GSID configured for IRQ 19 sshClient # [ 0.463553] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 sshClient # [ 0.464553] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 sshClient # [ 0.465552] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 sshClient # [ 0.466555] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.468608] iommu: Default domain type: Translated sshClient # [ 0.469464] iommu: DMA domain TLB invalidation policy: lazy mode sshClient # [ 0.470617] ACPI: bus type USB registered sshClient # [ 0.471427] usbcore: registered new interface driver usbfs sshClient # [ 0.472314] usbcore: registered new interface driver hub sshClient # [ 0.472547] usbcore: registered new device driver usb machine # [ 0.566206] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.474320] NetLabel: Initializing machine # [ 0.567820] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.474546] NetLabel: domain hash size = 128 sshClient # [ 0.475260] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.569173] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.475602] NetLabel: unlabeled traffic allowed by default machine # [ 0.570515] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) sshClient # [ 0.476539] PCI: Using ACPI for IRQ routing machine # [ 0.571790] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.572952] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.574463] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.575688] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.576993] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.578037] NET: Registered PF_XDP protocol family machine # [ 0.578981] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.580182] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.581239] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.582498] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.583690] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.584915] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.586833] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.589286] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.591310] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.593338] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.595036] PCI: CLS 0 bytes, default 64 machine # [ 0.595980] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.597804] Trying to unpack rootfs image as initramfs... sshClient # [ 0.521625] pci 0000:00:01.0: vgaarb: setting as boot VGA device sshClient # [ 0.522535] pci 0000:00:01.0: vgaarb: bridge control possible sshClient # [ 0.522535] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none sshClient # [ 0.522543] vgaarb: loaded sshClient # [ 0.523321] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 sshClient # [ 0.523540] hpet0: 3 comparators, 64-bit 100.000000 MHz counter sshClient # [ 0.527623] clocksource: Switched to clocksource kvm-clock sshClient # [ 0.531083] VFS: Disk quotas dquot_6.6.0 sshClient # [ 0.531806] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) sshClient # [ 0.533217] pnp: PnP ACPI init sshClient # [ 0.534026] ACPI: IRQ 4 override to edge(!), high(!) sshClient # [ 0.535037] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved sshClient # [ 0.536697] pnp: PnP ACPI: found 5 devices sshClient # [ 0.544299] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns sshClient # [ 0.546160] clocksource: Switched to clocksource acpi_pm sshClient # [ 0.547169] NET: Registered PF_INET protocol family machine # [ 0.646392] Initialise system trusted keyrings sshClient # [ 0.548255] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.647369] workingset: timestamp_bits=40 max_order=18 bucket_order=0 sshClient # [ 0.564915] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.566703] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.568093] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.569460] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) sshClient # [ 0.570753] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.669826] Key type asymmetric registered sshClient # [ 0.571899] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.670563] Asymmetric key parser 'x509' registered sshClient # [ 0.573227] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.671494] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) sshClient # [ 0.574374] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.575625] NET: Registered PF_UNIX/PF_LOCAL protocol family sshClient # [ 0.576647] NET: Registered PF_XDP protocol family sshClient # [ 0.577551] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.676860] io scheduler mq-deadline registered sshClient # [ 0.578735] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.677749] io scheduler kyber registered sshClient # [ 0.579810] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] sshClient # [ 0.581006] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] sshClient # [ 0.582196] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.681303] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled sshClient # [ 0.583403] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.682623] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A sshClient # [ 0.585138] ACPI: \_SB_.GSIA: Enabled at IRQ 16 sshClient # [ 0.587309] ACPI: \_SB_.GSIB: Enabled at IRQ 17 sshClient # [ 0.589279] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.688034] Linux agpgart interface v0.103 machine # [ 0.689010] ACPI: bus type drm_connector registered sshClient # [ 0.591171] ACPI: \_SB_.GSID: Enabled at IRQ 19 sshClient # [ 0.592780] PCI: CLS 0 bytes, default 64 machine # [ 0.692246] usbcore: registered new interface driver usbserial_generic sshClient # [ 0.593729] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.693355] usbserial: USB Serial support registered for generic sshClient # [ 0.595493] Trying to unpack rootfs image as initramfs... machine # [ 0.696740] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.696740] Please enable it if your BIOS has the CPPC option. machine # [ 0.699065] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.702878] drop_monitor: Initializing network drop monitor service machine # [ 0.704122] NET: Registered PF_INET6 protocol family machine # [ 0.707211] Segment Routing with IPv6 machine # [ 0.709751] In-situ OAM (IOAM) with IPv6 machine # [ 0.710859] IPI shorthand broadcast: enabled machine # [ 0.720127] sched_clock: Marking stable (576014896, 143707452)->(791651071, -71928723) machine # [ 0.723053] registered taskstats version 1 machine # [ 0.724034] Loading compiled-in X.509 certificates sshClient # [ 0.639737] Initialise system trusted keyrings sshClient # [ 0.643133] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.744742] Demotion targets for Node 0: null machine # [ 0.745621] Key type .fscrypt registered machine # [ 0.746304] Key type fscrypt-provisioning registered machine # [ 0.747245] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.749745] ima: Allocated hash algorithm: sha1 machine # [ 0.750556] ima: No architecture policies found machine # [ 0.754755] PM: Magic number: 14:374:814 machine # [ 0.756461] RAS: Correctable Errors collector initialized. sshClient # [ 0.665233] Key type asymmetric registered sshClient # [ 0.665947] Asymmetric key parser 'x509' registered machine # [ 0.764505] clk: Disabling unused clocks sshClient # [ 0.666842] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.767740] PM: genpd: Disabling unused power domains sshClient # [ 0.672205] io scheduler mq-deadline registered sshClient # [ 0.672990] io scheduler kyber registered sshClient # [ 0.676582] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled sshClient # [ 0.677898] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A sshClient # [ 0.681849] Linux agpgart interface v0.103 sshClient # [ 0.682638] ACPI: bus type drm_connector registered sshClient # [ 0.685490] usbcore: registered new interface driver usbserial_generic sshClient # [ 0.686599] usbserial: USB Serial support registered for generic sshClient # [ 0.690098] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. sshClient # [ 0.690098] Please enable it if your BIOS has the CPPC option. sshClient # [ 0.692407] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled sshClient # [ 0.696249] drop_monitor: Initializing network drop monitor service sshClient # [ 0.697454] NET: Registered PF_INET6 protocol family sshClient # [ 0.702189] Segment Routing with IPv6 sshClient # [ 0.702892] In-situ OAM (IOAM) with IPv6 sshClient # [ 0.703986] IPI shorthand broadcast: enabled sshClient # [ 0.712210] sched_clock: Marking stable (570014098, 142062008)->(785990312, -73914206) sshClient # [ 0.717338] registered taskstats version 1 sshClient # [ 0.718268] Loading compiled-in X.509 certificates sshClient # [ 0.737100] Demotion targets for Node 0: null sshClient # [ 0.737980] Key type .fscrypt registered sshClient # [ 0.738713] Key type fscrypt-provisioning registered sshClient # [ 0.739713] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.744115] ima: Allocated hash algorithm: sha1 sshClient # [ 0.744932] ima: No architecture policies found sshClient # [ 0.745930] PM: Magic number: 14:374:814 sshClient # [ 0.749604] RAS: Correctable Errors collector initialized. sshClient # [ 0.758395] clk: Disabling unused clocks sshClient # [ 0.761092] PM: genpd: Disabling unused power domains machine # [ 0.936937] Freeing initrd memory: 29828K machine # [ 0.940129] Freeing unused decrypted memory: 2028K machine # [ 0.942776] Freeing unused kernel image (initmem) memory: 3660K machine # [ 0.943883] Write protecting the kernel read-only data: 32768k machine # [ 0.945232] Freeing unused kernel image (text/rodata gap) memory: 296K machine # [ 0.946790] Freeing unused kernel image (rodata/data gap) memory: 684K machine # [ 0.997531] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.998623] Run /init as init process machine # [ 1.009376] systemd[1]: Inserted module 'autofs4' sshClient # [ 0.923430] Freeing initrd memory: 29804K sshClient # [ 0.926687] Freeing unused decrypted memory: 2028K sshClient # [ 0.929426] Freeing unused kernel image (initmem) memory: 3660K sshClient # [ 0.930625] Write protecting the kernel read-only data: 32768k machine # [ 1.029078] fuse: init (API version 7.45) sshClient # [ 0.931970] Freeing unused kernel image (text/rodata gap) memory: 296K sshClient # [ 0.933521] Freeing unused kernel image (rodata/data gap) memory: 684K machine # [ 1.036424] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.038884] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.041905] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.043815] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.048597] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.050126] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.056959] virtiofs virtio6: discovered new tag: shared machine # [ 1.058438] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.061676] virtiofs virtio7: discovered new tag: xchg machine # [ 1.063127] virtiofs virtio7: virtio_fs_setup_dax: No cache capability sshClient # [ 0.984346] x86/mm: Checked W+X mappings: passed, no W+X pages found. sshClient # [ 0.985462] Run /init as init process machine # [ 1.085887] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.087762] systemd[1]: systemd 263-409be20 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 +EXPERIMENTAL-ENVVAR) machine # [ 1.092882] systemd[1]: Detected virtualization kvm. machine # [ 1.093769] systemd[1]: Detected architecture x86-64. machine # [ 1.094628] systemd[1]: Running in initrd. sshClient # [ 0.996689] systemd[1]: Inserted module 'autofs4' machine # [ 1.095652] systemd[1]: Initializing machine ID from random generator. machine # [ 1.096815] systemd[1]: Hostname set to . sshClient # [ 1.016523] fuse: init (API version 7.45) sshClient # [ 1.023859] ACPI: \_SB_.GSIG: Enabled at IRQ 22 sshClient # [ 1.026377] ACPI: \_SB_.GSIH: Enabled at IRQ 23 sshClient # [ 1.029262] ACPI: \_SB_.GSIE: Enabled at IRQ 20 sshClient # [ 1.031203] ACPI: \_SB_.GSIF: Enabled at IRQ 21 sshClient # [ 1.035852] virtiofs virtio5: discovered new tag: nix-store sshClient # [ 1.037653] virtiofs virtio5: virtio_fs_setup_dax: No cache capability sshClient # [ 1.044347] virtiofs virtio6: discovered new tag: shared sshClient # [ 1.045835] virtiofs virtio6: virtio_fs_setup_dax: No cache capability sshClient # [ 1.050549] virtiofs virtio7: discovered new tag: xchg sshClient # [ 1.052132] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.169868] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 1.082858] systemd[1]: Successfully made /usr/ read-only. sshClient # [ 1.084652] systemd[1]: systemd 263-409be20 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 +EXPERIMENTAL-ENVVAR) sshClient # [ 1.089887] systemd[1]: Detected virtualization kvm. sshClient # [ 1.090751] systemd[1]: Detected architecture x86-64. sshClient # [ 1.091630] systemd[1]: Running in initrd. sshClient # [ 1.092603] systemd[1]: Initializing machine ID from random generator. sshClient # [ 1.093760] systemd[1]: Hostname set to . machine # [ 1.207240] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.211053] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.212336] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.213812] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.214977] systemd[1]: Reached target Path Units. machine # [ 1.215931] systemd[1]: Reached target Slice Units. machine # [ 1.216866] systemd[1]: Reached target Swaps. machine # [ 1.217724] systemd[1]: Reached target Timer Units. machine # [ 1.218777] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.220089] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.221243] systemd[1]: Listening on Journal Sockets. machine # [ 1.222256] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.223216] systemd[1]: Reached target Socket Units. machine # [ 1.225106] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.228799] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.237799] systemd[1]: Starting Journal Service... machine # [ 1.249820] systemd[1]: Starting Load Kernel Modules... sshClient # [ 1.164355] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.265283] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.270514] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.284333] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.291430] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 1.199703] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.299242] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 1.203370] systemd[1]: Created slice Slice /system/modprobe. sshClient # [ 1.204503] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 1.205840] systemd[1]: Expecting device /dev/disk/by-label/nixos... sshClient # [ 1.206942] systemd[1]: Reached target Path Units. sshClient # [ 1.207809] systemd[1]: Reached target Slice Units. machine # [ 1.305207] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config sshClient # [ 1.208665] systemd[1]: Reached target Swaps. sshClient # [ 1.209442] systemd[1]: Reached target Timer Units. sshClient # [ 1.210376] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 1.211566] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.309638] systemd-journald[65]: Collecting audit messages is disabled. sshClient # [ 1.212671] systemd[1]: Listening on Journal Sockets. sshClient # [ 1.213613] systemd[1]: Listening on udev Kernel Socket. sshClient # [ 1.214549] systemd[1]: Reached target Socket Units. sshClient # [ 1.216262] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.317837] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 1.219970] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 1.226696] systemd[1]: Starting Journal Service... machine # [ 1.328113] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.337763] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev sshClient # [ 1.237960] systemd[1]: Starting Load Kernel Modules... sshClient # [ 1.253549] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 1.260299] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.360345] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. sshClient # [ 1.274149] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.373022] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 1.276970] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 1.284493] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.385854] systemd[1]: Finished Load Kernel Modules. sshClient # [ 1.289729] systemd-journald[65]: Collecting audit messages is disabled. sshClient # [ 1.291363] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.398043] systemd[1]: Starting Apply Kernel Variables... sshClient # [ 1.302160] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 1.310137] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. sshClient # [ 1.318350] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.425306] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.285631] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.433081] systemd[1]: Started Journal Service. machine # machine # [ 1.290344] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.291472] systemd-modules-load[66]: Inserted module 'virtio_gpu' sshClient # [ 1.339634] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.297703] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 1.348278] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.305098] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.306157] systemd[1]: Reached target Local File Systems. machine # [ 1.307256] systemd[1]: Starting Create System Files and Directories... sshClient # [ 1.360600] systemd[1]: Finished Load Kernel Modules. machine # [ 1.316070] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 1.369286] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.343073] systemd[1]: Finished Create System Files and Directories. sshClient # [ 1.389167] systemd[1]: Finished Create Static Device Nodes in /dev. sshClient # [ 1.394303] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 1.399160] systemd[1]: Reached target Local File Systems. sshClient # [ 1.406288] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 1.265610] systemd-modules-load[66]: Inserted module 'dm_mod' sshClient # [ 1.266923] systemd-modules-load[66]: Inserted module 'virtio_balloon' sshClient # [ 1.269293] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.365832] systemd-udevd[80]: Using default interface naming scheme 'v261'. sshClient # [ 1.417370] systemd[1]: Started Journal Service. sshClient # [ 1.281961] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.389743] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 1.294301] systemd[1]: Starting Create System Files and Directories... sshClient # [ 1.319425] systemd[1]: Finished Create System Files and Directories. sshClient # [ 1.327279] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.436416] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.439132] systemd[1]: Reached target System Initialization. machine # [ 1.440623] systemd[1]: Reached target Basic System. sshClient # [ 1.350471] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 1.406591] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 1.408386] systemd[1]: Reached target System Initialization. sshClient # [ 1.410274] systemd[1]: Reached target Basic System. machine # [ 1.728869] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.743075] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.743887] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.745568] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.749474] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.761139] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.762175] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 1.763929] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.772062] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.773171] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.776751] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.777861] usb usb1: Product: EHCI Host Controller machine # [ 1.778545] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd machine # [ 1.780907] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.782677] hub 1-0:1.0: USB hub found machine # [ 1.784664] hub 1-0:1.0: 6 ports detected machine # [ 1.788062] uhci_hcd 0000:00:1d.0: UHCI Host Controller sshClient # [ 1.690245] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.788789] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 sshClient # [ 1.696346] virtio_blk virtio2: 1/0/0 default/read/poll queues sshClient # [ 1.701943] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.802646] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.803830] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 sshClient # [ 1.707650] serio: i8042 AUX port at 0x60,0x64 irq 12 sshClient # [ 1.709392] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.813765] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.814894] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.723269] ehci-pci 0000:00:1d.7: EHCI Host Controller sshClient # [ 1.724160] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 sshClient # [ 1.725891] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 sshClient # [ 1.733106] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.832065] usb usb2: Product: UHCI Host Controller sshClient # [ 1.735497] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 sshClient # [ 1.736676] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.740093] usb usb1: Product: EHCI Host Controller sshClient # [ 1.740812] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd machine # [ 1.695370] systemd[1]: Starting Virtual Console Setup... sshClient # [ 1.743643] usb usb1: SerialNumber: 0000:00:1d.7 sshClient # [ 1.745495] hub 1-0:1.0: USB hub found sshClient # [ 1.746690] hub 1-0:1.0: 6 ports detected machine # [ 1.845527] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.846497] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.849088] hub 2-0:1.0: USB hub found sshClient # [ 1.754107] uhci_hcd 0000:00:1d.0: UHCI Host Controller sshClient # [ 1.754821] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.867741] hub 2-0:1.0: 2 ports detected sshClient # [ 1.769797] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.730671] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. sshClient # [ 1.777826] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 sshClient # [ 1.779670] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.878552] uhci_hcd 0000:00:1d.1: UHCI Host Controller sshClient # [ 1.780843] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.879284] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.739432] systemd[1]: Finished Virtual Console Setup. machine # [ 1.741544] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.744053] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.891106] SCSI subsystem initialized sshClient # [ 1.655360] systemd[1]: Starting Virtual Console Setup... sshClient # [ 1.801397] usb usb2: Product: UHCI Host Controller machine # [ 1.899275] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.761762] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.763200] systemd[1]: Reached target Initrd Root Device. machine # [ 1.767072] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... sshClient # [ 1.669661] (udev-worker)[85]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.915577] uhci_hcd 0000:00:1d.1: detected 2 ports sshClient # [ 1.817568] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd sshClient # [ 1.818382] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.917197] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 sshClient # [ 1.677062] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.931007] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.933303] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.935756] usb usb3: Product: UHCI Host Controller machine # [ 1.936471] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd sshClient # [ 1.697525] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.938778] usb usb3: SerialNumber: 0000:00:1d.1 sshClient # [ 1.700244] systemd[1]: Finished Virtual Console Setup. machine # [ 1.942058] hub 3-0:1.0: USB hub found sshClient # [ 1.845152] hub 2-0:1.0: USB hub found machine # [ 1.945488] hub 3-0:1.0: 2 ports detected sshClient # [ 1.847806] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 sshClient # [ 1.850393] hub 2-0:1.0: 2 ports detected machine # [ 1.806462] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.952804] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 1.953553] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.813869] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 1.960794] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.961599] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 sshClient # [ 1.724560] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.964938] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.725625] systemd[1]: Reached target Initrd Root Device. machine # [ 1.967782] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.728278] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 1.969767] usb usb4: Product: UHCI Host Controller sshClient # [ 1.872190] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.970515] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd sshClient # [ 1.872927] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.973762] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 1.975842] hub 4-0:1.0: USB hub found sshClient # [ 1.877650] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.977766] hub 4-0:1.0: 2 ports detected sshClient # [ 1.879941] SCSI subsystem initialized sshClient # [ 1.883484] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 sshClient # [ 1.890170] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.891321] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.896602] usb usb3: Product: UHCI Host Controller sshClient # [ 1.898114] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd sshClient # [ 1.898900] usb usb3: SerialNumber: 0000:00:1d.1 sshClient # [ 1.901520] hub 3-0:1.0: USB hub found sshClient # [ 1.903128] hub 3-0:1.0: 2 ports detected sshClient # [ 1.908953] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 1.909707] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 sshClient # [ 1.914909] uhci_hcd 0000:00:1d.2: detected 2 ports sshClient # [ 1.917312] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 2.015287] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.016439] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) sshClient # [ 1.776663] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.017732] ahci 0000:00:1f.2: flags: 64bit ncq only sshClient # [ 1.921275] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.020881] scsi host0: ahci machine # [ 2.022568] scsi host1: ahci sshClient # [ 1.782698] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.023690] scsi host2: ahci machine # [ 2.025227] scsi host3: ahci machine # [ 2.026613] scsi host4: ahci sshClient # [ 1.928186] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.027745] usb 1-1: new high-speed USB device number 2 using ehci-pci sshClient # [ 1.930151] usb usb4: Product: UHCI Host Controller machine # [ 2.029192] scsi host5: ahci sshClient # [ 1.930886] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 2.030336] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 sshClient # [ 1.933130] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 2.031607] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 2.032848] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 sshClient # [ 1.935421] hub 4-0:1.0: USB hub found machine # [ 2.034016] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 sshClient # [ 1.937137] hub 4-0:1.0: 2 ports detected machine # [ 2.035165] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 2.036521] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 sshClient # [ 1.978784] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode sshClient # [ 1.980036] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) sshClient # [ 1.981407] ahci 0000:00:1f.2: flags: 64bit ncq only sshClient # [ 1.984093] scsi host0: ahci sshClient # [ 1.985568] scsi host1: ahci sshClient # [ 1.986972] scsi host2: ahci sshClient # [ 1.987509] usb 1-1: new high-speed USB device number 2 using ehci-pci sshClient # [ 1.989593] scsi host3: ahci sshClient # [ 1.990874] scsi host4: ahci sshClient # [ 1.992450] scsi host5: ahci sshClient # [ 1.993001] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 sshClient # [ 1.994979] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 1.996309] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 sshClient # [ 1.997544] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 sshClient # [ 1.998745] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 sshClient # [ 1.999951] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.157786] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.159067] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.160516] usb 1-1: Product: QEMU USB Tablet machine # [ 2.161194] usb 1-1: Manufacturer: QEMU machine # [ 2.161834] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.179629] hid: raw HID events driver (C) Jiri Kosina sshClient # [ 2.117224] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 sshClient # [ 2.120106] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 sshClient # [ 2.123330] usb 1-1: Product: QEMU USB Tablet sshClient # [ 2.125162] usb 1-1: Manufacturer: QEMU sshClient # [ 2.126863] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 sshClient # [ 2.159707] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.135442] systemd[1]: Mounting /sysroot... machine # [ 2.347919] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.348858] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.349732] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.350586] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.351550] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.352342] ata3.00: applying bridge limits machine # [ 2.353426] ata3.00: configured for UDMA/100 machine # [ 2.354200] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.355085] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.356214] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 sshClient # [ 2.127126] systemd[1]: Mounting /sysroot... machine # [ 2.413944] usbcore: registered new interface driver usbhid sshClient # [ 2.315773] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.414737] usbhid: USB HID core driver sshClient # [ 2.316737] ata4: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.318430] ata5: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.319879] ata2: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.322892] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) sshClient # [ 2.323824] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 sshClient # [ 2.324615] ata3.00: applying bridge limits sshClient # [ 2.325634] ata3.00: configured for UDMA/100 sshClient # [ 2.326440] ata6: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.327486] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.428628] 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.433891] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.434959] 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.449850] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.484318] EXT4-fs (vda): mounted filesystem 4c4695af-b89c-4454-ad86-57559ecf35bf r/w with ordered data mode. Quota mode: none. machine # [ 2.345445] systemd[1]: Mounted /sysroot. machine # [ 2.346803] systemd[1]: Reached target Initrd Root File System. sshClient # [ 2.393199] usbcore: registered new interface driver usbhid sshClient # [ 2.393984] usbhid: USB HID core driver machine # [ 2.349115] systemd[1]: Starting Mountpoints Configured in the Real Root... sshClient # [ 2.397190] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.364548] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload. sshClient # [ 2.416253] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.370067] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.371576] systemd[1]: Reloading... sshClient # [ 2.419485] 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.421092] 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 sshClient # [ 2.434044] EXT4-fs (vda): mounted filesystem 6e0dbe1f-8f21-476e-af1d-7072c9cb10a2 r/w with ordered data mode. Quota mode: none. sshClient # [ 2.299353] systemd[1]: Mounted /sysroot. sshClient # [ 2.300426] systemd[1]: Reached target Initrd Root File System. sshClient # [ 2.303359] systemd[1]: Starting Mountpoints Configured in the Real Root... sshClient # [ 2.318066] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload. sshClient # [ 2.320813] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)... sshClient # [ 2.322254] systemd[1]: Reloading... machine # [ 2.444326] systemd[1]: Reloading finished in 74 ms. machine # [ 2.453084] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace... machine # [ 2.456166] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace... machine # [ 2.462052] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.464079] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.465073] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. sshClient # [ 2.393125] systemd[1]: Reloading finished in 69 ms. sshClient # [ 2.400624] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace... sshClient # [ 2.405179] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace... sshClient # [ 2.409027] systemd[1]: initrd-parse-etc.service: Deactivated successfully. sshClient # [ 2.410102] systemd[1]: Finished Mountpoints Configured in the Real Root. sshClient # [ 2.411668] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.137103] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.140068] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.144141] systemd[1]: Mounting /sysroot/run... machine # [ 3.150144] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.153279] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.182954] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.185709] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.187683] systemd[1]: Mounted /sysroot/run. machine # [ 3.188615] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.191976] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.194919] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.205568] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.206936] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.128628] systemd[1]: Mounting /sysroot/nix/.ro-store... sshClient # [ 3.131747] systemd[1]: Mounting /sysroot/nix/.rw-store... sshClient # [ 3.136138] systemd[1]: Mounting /sysroot/run... sshClient # [ 3.138136] systemd[1]: Mounting /sysroot/tmp/shared... sshClient # [ 3.146140] systemd[1]: Mounting /sysroot/tmp/xchg... sshClient # [ 3.172726] systemd[1]: Mounted /sysroot/nix/.ro-store. sshClient # [ 3.173850] systemd[1]: Mounted /sysroot/nix/.rw-store. sshClient # [ 3.174870] systemd[1]: Mounted /sysroot/run. sshClient # [ 3.176331] systemd[1]: Mounted /sysroot/tmp/shared. sshClient # [ 3.180732] systemd[1]: Mounted /sysroot/tmp/xchg. sshClient # [ 3.184354] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 3.193381] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 3.194823] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.136309] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.158718] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.160075] systemd[1]: Reached target Initrd File Systems. machine # [ 4.162034] systemd[1]: Starting Find NixOS closure... machine # [ 4.164891] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.185813] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.188577] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.195791] systemd[1]: Finished Find NixOS closure. machine # [ 4.196924] systemd[1]: Reached target Initrd Default Target. machine # [ 4.198745] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.211778] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.213072] systemd[1]: Stopped target Basic System. machine # [ 4.215208] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.215976] systemd[1]: Stopped target Path Units. machine # [ 4.216712] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.217717] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.218778] systemd[1]: Stopped target Slice Units. machine # [ 4.219467] systemd[1]: Stopped target Socket Units. machine # [ 4.220257] systemd[1]: Stopped target System Initialization. machine # [ 4.221085] systemd[1]: Stopped target Swaps. machine # [ 4.221985] systemd[1]: Stopped target Timer Units. machine # [ 4.222939] systemd[1]: dbus.socket: Deactivated successfully. sshClient # [ 4.127703] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.224827] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.225669] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.226716] systemd[1]: Stopped Find NixOS closure. machine # [ 4.227764] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.228756] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.230319] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.231374] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.232662] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.234395] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.236121] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.237163] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.238265] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.239261] systemd[1]: Stopped target Local File Systems. machine # [ 4.241118] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.242081] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.243228] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.245107] systemd[1]: Stopping Rule-based Manager for Device Events and Files... sshClient # [ 4.149258] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.246153] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 4.150485] systemd[1]: Reached target Initrd File Systems. machine # [ 4.247620] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 4.152335] systemd[1]: Starting Find NixOS closure... sshClient # [ 4.156359] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.255162] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.259301] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.264402] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.266160] systemd[1]: Stopped Rule-based Manager for Device Events and Files. sshClient # [ 4.173901] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.272093] systemd[1]: Starting Cleanup udev Database... sshClient # [ 4.175701] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.272888] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.275130] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.275992] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.277205] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.278221] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.279205] systemd[1]: Stopped Create List of Static Device Nodes. sshClient # [ 4.182917] systemd[1]: Finished Find NixOS closure. machine # [ 4.280099] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 4.184400] systemd[1]: Reached target Initrd Default Target. machine # [ 4.282648] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 4.186306] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... sshClient # [ 4.199238] systemd[1]: Stopped target Initrd Default Target. sshClient # [ 4.200262] systemd[1]: Stopped target Basic System. sshClient # [ 4.201157] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.297373] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. sshClient # [ 4.202030] systemd[1]: Stopped target Path Units. machine # [ 4.298971] systemd[1]: Finished Cleanup udev Database. sshClient # [ 4.202899] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.300405] systemd[1]: Reached target Switch Root. sshClient # [ 4.205113] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.302326] systemd[1]: Starting NixOS Activation... sshClient # [ 4.206151] systemd[1]: Stopped target Slice Units. sshClient # [ 4.206816] systemd[1]: Stopped target Socket Units. sshClient # [ 4.207562] systemd[1]: Stopped target System Initialization. sshClient # [ 4.208536] systemd[1]: Stopped target Swaps. sshClient # [ 4.209173] systemd[1]: Stopped target Timer Units. sshClient # [ 4.209833] systemd[1]: dbus.socket: Deactivated successfully. sshClient # [ 4.210724] systemd[1]: Closed D-Bus System Message Bus Socket. sshClient # [ 4.212148] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. sshClient # [ 4.213136] systemd[1]: Stopped Find NixOS closure. sshClient # [ 4.215259] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 4.216290] systemd[1]: systemd-sysctl.service: Deactivated successfully. sshClient # [ 4.217443] systemd[1]: Stopped Apply Kernel Variables. sshClient # [ 4.218527] systemd[1]: systemd-modules-load.service: Deactivated successfully. sshClient # [ 4.220131] systemd[1]: Stopped Load Kernel Modules. sshClient # [ 4.220824] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. sshClient # [ 4.221974] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. sshClient # [ 4.223278] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. sshClient # [ 4.224481] systemd[1]: Stopped Create System Files and Directories. sshClient # [ 4.225642] systemd[1]: Stopped target Local File Systems. sshClient # [ 4.227168] systemd[1]: Stopped target Preparation for Local File Systems. sshClient # [ 4.228200] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. sshClient # [ 4.229312] systemd[1]: Stopped Coldplug All udev Devices. sshClient # [ 4.231939] systemd[1]: Stopping Rule-based Manager for Device Events and Files... sshClient # [ 4.232969] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 4.236080] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 4.243078] systemd[1]: initrd-cleanup.service: Deactivated successfully. sshClient # [ 4.245185] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. sshClient # [ 4.251176] systemd[1]: systemd-udevd.service: Deactivated successfully. sshClient # [ 4.252241] systemd[1]: Stopped Rule-based Manager for Device Events and Files. sshClient # [ 4.253803] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 4.255281] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 4.258225] systemd[1]: Starting Cleanup udev Database... sshClient # [ 4.259191] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. sshClient # [ 4.262192] systemd[1]: Stopped Create Static Device Nodes in /dev. sshClient # [ 4.263201] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. sshClient # [ 4.264625] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. sshClient # [ 4.265596] systemd[1]: kmod-static-nodes.service: Deactivated successfully. sshClient # [ 4.267138] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.377921] initrd-nixos-activation-start[188]: booting system configuration /nix/store/2mw85zxm6chfqxq53kkyc89z8pghlih4-nixos-system-machine-test sshClient # [ 4.282803] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. sshClient # [ 4.284502] systemd[1]: Finished Cleanup udev Database. sshClient # [ 4.285762] systemd[1]: Reached target Switch Root. sshClient # [ 4.287512] systemd[1]: Starting NixOS Activation... machine # [ 4.401374] initrd-nixos-activation-start[188]: running activation script... sshClient # [ 4.354708] initrd-nixos-activation-start[188]: booting system configuration /nix/store/cv1vh5fjx6vaaw2dclpi2ifdsi00y2l4-nixos-system-sshClient-test sshClient # [ 4.381867] initrd-nixos-activation-start[188]: running activation script... machine # [ 4.588812] initrd-nixos-activation-start[211]: setting up /etc... sshClient # [ 4.549362] initrd-nixos-activation-start[211]: setting up /etc... machine # [ 4.687991] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.690082] systemd[1]: Finished NixOS Activation. machine # [ 4.691506] systemd[1]: Starting Switch Root... machine # [ 4.705065] systemd[1]: Switching root. sshClient # [ 4.648604] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. sshClient # [ 4.650220] systemd[1]: Finished NixOS Activation. sshClient # [ 4.651982] systemd[1]: Starting Switch Root... sshClient # [ 4.664923] systemd[1]: Switching root. machine # [ 4.978894] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). sshClient # [ 4.935029] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 5.062465] NET: Registered PF_VSOCK protocol family machine # [ 5.087850] systemd[1]: systemd 263-409be20 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 +EXPERIMENTAL-ENVVAR) machine # [ 5.091885] systemd[1]: Detected virtualization kvm. sshClient # [ 4.993760] NET: Registered PF_VSOCK protocol family machine # [ 5.092610] systemd[1]: Detected architecture x86-64. machine # [ 5.093346] systemd[1]: Detected first boot. machine # [ 5.095010] systemd[1]: Initializing machine ID from random generator. sshClient # [ 5.017646] systemd[1]: systemd 263-409be20 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 +EXPERIMENTAL-ENVVAR) sshClient # [ 5.021808] systemd[1]: Detected virtualization kvm. sshClient # [ 5.022533] systemd[1]: Detected architecture x86-64. sshClient # [ 5.023282] systemd[1]: Detected first boot. sshClient # [ 5.025025] systemd[1]: Initializing machine ID from random generator. machine # [ 5.182820] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 5.111296] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.272409] systemd[1]: Applying preset policy. sshClient # [ 5.214724] systemd[1]: Applying preset policy. machine # [ 5.456291] systemd[1]: Populated /etc with preset unit settings. sshClient # [ 5.387485] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.643853] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 5.645195] systemd[1]: Stopped initrd-switch-root.service. machine # [ 5.647186] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.649328] systemd[1]: Created slice Slice /system/getty. machine # [ 5.650620] systemd[1]: Created slice User and Session Slice. machine # [ 5.651551] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.652776] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.653854] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.654551] systemd[1]: Expecting device /dev/ttyS0... machine # [ 5.655295] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.656108] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.656871] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.657655] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.658549] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.659491] systemd[1]: Reached target Path Units. machine # [ 5.660172] systemd[1]: Reached target Remote File Systems. machine # [ 5.660942] systemd[1]: Reached target Slice Units. machine # [ 5.661652] systemd[1]: Reached target Swaps. machine # [ 5.663282] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.665562] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.667261] systemd[1]: Listening on Credential Encryption/Decryption. sshClient # [ 5.571018] systemd[1]: initrd-switch-root.service: Deactivated successfully. sshClient # [ 5.572642] systemd[1]: Stopped initrd-switch-root.service. sshClient # [ 5.574649] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. sshClient # [ 5.576800] systemd[1]: Created slice Slice /system/getty. sshClient # [ 5.578196] systemd[1]: Created slice User and Session Slice. sshClient # [ 5.579090] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 5.580258] systemd[1]: Started Forward Password Requests to Wall Directory Watch. sshClient # [ 5.581404] systemd[1]: Expecting device /dev/hvc0... sshClient # [ 5.582112] systemd[1]: Expecting device /dev/ttyS0... machine # [ 5.669024] systemd[1]: Listening on Factory Reset Management. sshClient # [ 5.582823] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.681568] systemd[1]: Listening on Hostname Service Socket. sshClient # [ 5.583676] systemd[1]: Stopped target initrd-fs.target. sshClient # [ 5.584447] systemd[1]: Stopped target initrd-root-fs.target. sshClient # [ 5.585239] systemd[1]: Stopped target initrd-switch-root.target. sshClient # [ 5.586067] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.684449] systemd[1]: Starting Journal Log Access Socket... sshClient # [ 5.586957] systemd[1]: Reached target Path Units. sshClient # [ 5.587699] systemd[1]: Reached target Remote File Systems. sshClient # [ 5.588488] systemd[1]: Reached target Slice Units. machine # [ 5.687017] systemd[1]: Listening on Journal Audit Socket. sshClient # [ 5.589193] systemd[1]: Reached target Swaps. machine # [ 5.688751] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.689848] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.690952] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.692209] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.696225] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.697260] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.698139] systemd[1]: Listening on User Database Manager Socket. sshClient # [ 5.590793] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.700576] systemd[1]: Mounting Huge Pages File System... sshClient # [ 5.604564] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.703056] systemd[1]: Mounting POSIX Message Queue File System... sshClient # [ 5.606314] systemd[1]: Listening on Credential Encryption/Decryption. sshClient # [ 5.608143] systemd[1]: Listening on Factory Reset Management. sshClient # [ 5.609032] systemd[1]: Listening on Hostname Service Socket. sshClient # [ 5.611842] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.710245] systemd[1]: Mounting Kernel Debug File System... sshClient # [ 5.613450] systemd[1]: Listening on Journal Audit Socket. sshClient # [ 5.616113] systemd[1]: Listening on Console Output Muting Service Socket. sshClient # [ 5.617196] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. sshClient # [ 5.618289] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.619556] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.719683] systemd[1]: Mounting Kernel Trace File System... sshClient # [ 5.623310] systemd[1]: Listening on Disk Repartitioning Service Socket. sshClient # [ 5.624341] systemd[1]: Listening on udev Varlink Socket. sshClient # [ 5.625235] systemd[1]: Listening on User Database Manager Socket. sshClient # [ 5.627616] systemd[1]: Mounting Huge Pages File System... machine # [ 5.728769] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 5.631648] systemd[1]: Mounting POSIX Message Queue File System... sshClient # [ 5.638412] systemd[1]: Mounting Kernel Debug File System... sshClient # [ 5.644456] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.743988] systemd[1]: Starting Load Kernel Module configfs... machine # [ 5.750292] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm sshClient # [ 5.653169] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.758473] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore sshClient # [ 5.661623] systemd[1]: Starting Load Kernel Module configfs... machine # [ 5.765840] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 5.670611] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.774150] systemd[1]: Mounting FUSE Control File System... sshClient # [ 5.679252] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.780850] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 5.687342] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 5.702578] systemd[1]: Mounting FUSE Control File System... machine # [ 5.801486] systemd[1]: Starting Journal Service... sshClient # [ 5.707848] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.808745] systemd[1]: Starting Load Kernel Modules... machine # [ 5.818806] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... sshClient # [ 5.722145] systemd[1]: Starting Journal Service... sshClient # [ 5.728959] systemd[1]: Starting Load Kernel Modules... machine # [ 5.831816] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.837827] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.741210] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.843443] systemd[1]: Starting Coldplug All udev Devices... sshClient # [ 5.749966] systemd[1]: Starting Remount Root and Kernel File Systems... sshClient # [ 5.756130] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.858855] systemd-journald[282]: Collecting audit messages is enabled. sshClient # [ 5.764229] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.862882] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.868013] systemd[1]: Mounted Huge Pages File System. machine # [ 5.871412] systemd[1]: Mounted POSIX Message Queue File System. sshClient # [ 5.776085] systemd[1]: Listening on Journal Log Access Socket. sshClient # [ 5.777017] systemd[1]: Mounted Huge Pages File System. sshClient # [ 5.779536] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 5.877905] systemd[1]: Mounted Kernel Debug File System. sshClient # [ 5.780629] systemd-journald[282]: Collecting audit messages is enabled. machine # [ 5.884147] systemd[1]: Mounted Kernel Trace File System. sshClient # [ 5.787849] systemd[1]: Mounted Kernel Debug File System. machine # [ 5.746600] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.892034] systemd[1]: Started Journal Service. sshClient # [ 5.796407] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.750635] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. machine # [ 5.753574] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 5.898873] loop: module loaded machine # [ 5.756475] systemd[1]: systemd-journald.service: Deactivated successfully. sshClient # [ 5.802174] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 5.757861] systemd-modules-load[283]: Inserted module 'loop' sshClient # [ 5.659987] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.761473] systemd[1]: Finished Create List of Static Device Nodes. sshClient # [ 5.665396] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 5.762772] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 5.667348] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. sshClient # [ 5.811395] systemd[1]: Started Journal Service. machine # [ 5.766552] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 5.670410] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 5.767500] systemd[1]: Mounted FUSE Control File System. sshClient # [ 5.676436] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 5.680242] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 5.681236] systemd[1]: Mounted FUSE Control File System. sshClient # [ 5.824737] loop: module loaded machine # [ 5.780065] systemd[1]: Finished Load Kernel Modules. sshClient # [ 5.687368] systemd-modules-load[283]: Inserted module 'loop' machine # [ 5.793663] systemd[1]: Mounting Kernel Configuration File System... sshClient # [ 5.698249] systemd[1]: Finished Load Kernel Modules. machine # [ 5.938730] EXT4-fs (vda): re-mounted 4c4695af-b89c-4454-ad86-57559ecf35bf. sshClient # [ 5.844121] EXT4-fs (vda): re-mounted 6e0dbe1f-8f21-476e-af1d-7072c9cb10a2. machine # [ 5.802820] systemd[1]: Starting Firewall... sshClient # [ 5.708114] systemd[1]: Mounting Kernel Configuration File System... sshClient # [ 5.712076] systemd[1]: Starting Firewall... sshClient # [ 5.715131] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.813446] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.825087] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 5.735961] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 5.835745] systemd[1]: Finished Remount Root and Kernel File Systems. sshClient # [ 5.743182] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 5.843062] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 5.844190] systemd-oomd[285]: No swap; memory pressure usage will be degraded sshClient # [ 5.748113] systemd[1]: Listening on Disk Image Download Service Socket. sshClient # [ 5.758779] systemd-oomd[284]: No swap; memory pressure usage will be degraded sshClient # [ 5.763534] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.860405] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.861574] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 5.766196] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.872100] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 5.872913] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.876985] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. sshClient # [ 5.784731] systemd[1]: Starting Load/Save OS Random Seed... sshClient # [ 5.785600] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.790986] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. sshClient # [ 5.977177] systemd-journald[282]: Received client request to flush runtime journal. machine # [ 6.087356] systemd-journald[282]: Received client request to flush runtime journal. sshClient # [ 5.922438] systemd[1]: Mounted Kernel Configuration File System. sshClient # [ 5.924333] systemd[1]: Finished Load/Save OS Random Seed. sshClient # [ 5.926336] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 5.930480] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.027590] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.028587] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.030488] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.033509] systemd[1]: Finished Flush Journal to Persistent Storage. sshClient # [ 5.947129] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. sshClient # [ 5.950399] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.063133] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.070607] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.124395] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 6.029161] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.143315] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.144498] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 6.048377] systemd[1]: Finished Create Static Device Nodes in /dev. sshClient # [ 6.049590] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.147881] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 6.052779] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.193284] systemd-udevd[324]: Using default interface naming scheme 'v261'. sshClient # [ 6.096820] systemd-udevd[322]: Using default interface naming scheme 'v261'. sshClient # [ 6.107382] systemd[1]: Starting User Database Manager... machine # [ 6.205081] systemd[1]: Starting User Database Manager... sshClient # [ 6.145277] systemd[1]: Started User Database Manager. machine # [ 6.247367] systemd[1]: Started User Database Manager. sshClient # [ 6.198810] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.307350] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 6.253782] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.376052] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 6.329697] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.449927] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. sshClient # [ 6.370080] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 6.476456] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. sshClient # [ 6.387336] (udev-worker)[354]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 6.389341] (udev-worker)[354]: Network interface NamePolicy= disabled on kernel command line. machine # [ 6.504704] systemd[1]: Mounting /run/wrappers... machine # [ 6.521285] (udev-worker)[364]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 6.524501] (udev-worker)[364]: Network interface NamePolicy= disabled on kernel command line. sshClient # [ 6.433750] systemd[1]: Mounting /run/wrappers... machine # [ 6.551925] systemd[1]: Mounted /run/wrappers. machine # [ 6.552859] systemd[1]: Reached target Local File Systems. machine # [ 6.557076] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.561159] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.562092] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.566111] systemd[1]: Starting Create System Files and Directories... sshClient # [ 6.472978] systemd[1]: Mounted /run/wrappers. sshClient # [ 6.473841] systemd[1]: Reached target Local File Systems. sshClient # [ 6.478160] systemd[1]: Listening on Boot Loader Control Service Socket. sshClient # [ 6.482224] systemd[1]: Starting Create SUID/SGID Wrappers... sshClient # [ 6.483076] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 6.486759] systemd[1]: Starting Create System Files and Directories... sshClient # [ 6.526093] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 6.527204] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 6.535982] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore sshClient # [ 6.540063] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 6.541409] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 6.543480] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 6.545042] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.546212] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.679471] systemd[1]: Finished Create System Files and Directories. machine # [ 6.686144] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 6.691289] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.694178] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.696414] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.697631] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.699949] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.701967] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.706668] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.708195] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.612534] systemd[1]: Finished Create System Files and Directories. machine # [ 6.709401] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.619447] systemd[1]: Starting Rebuild Journal Catalog... sshClient # [ 6.626186] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.779714] systemd[1]: Finished Record System Boot/Shutdown in UTMP. sshClient # [ 6.694226] systemd[1]: Finished Record System Boot/Shutdown in UTMP. sshClient # [ 6.845037] mousedev: PS/2 mouse device common for all mice sshClient # [ 6.716987] systemd[1]: Finished Rebuild Journal Catalog. sshClient # [ 6.722903] systemd[1]: Starting Update is Completed... machine # [ 6.826095] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 6.832355] systemd[1]: Starting Update is Completed... sshClient # [ 6.903310] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 sshClient # [ 6.769322] systemd[1]: Finished Update is Completed. machine # [ 6.880776] systemd[1]: Finished Update is Completed. sshClient # [ 6.955731] ACPI: button: Power Button [PWRF] machine # [ 7.073600] mousedev: PS/2 mouse device common for all mice sshClient # [ 7.008733] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.108853] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 sshClient # [ 7.032532] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 7.136501] ACPI: button: Power Button [PWRF] sshClient # [ 7.053765] parport_pc 00:02: reported by Plug and Play ACPI sshClient # [ 7.057905] rtc_cmos PNP0B00:00: registered as rtc0 sshClient # [ 7.058730] rtc_cmos PNP0B00:00: setting system clock to 2026-10-18T02:49:41 UTC (1792291781) sshClient # [ 7.059939] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs sshClient # [ 7.061384] systemd-journald[282]: Time jumped backwards, rotating. sshClient # [ 7.067440] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 7.059785] systemd[1]: Finished Firewall. machine # [ 7.215402] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.224807] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console sshClient # [ 7.002152] systemd[1]: Finished Firewall. sshClient # [ 7.032506] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. sshClient # [ 7.033683] systemd[1]: Finished Create SUID/SGID Wrappers. sshClient # [ 7.034785] systemd[1]: Reached target System Initialization. sshClient # [ 7.038211] systemd[1]: Started Discard unused filesystem blocks once a week. sshClient # [ 7.039213] systemd[1]: Started Daily Cleanup of Temporary Directories. sshClient # [ 7.040134] systemd[1]: Reached target Timer Units. sshClient # [ 7.040835] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 7.041735] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 7.140784] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. sshClient # [ 7.044890] systemd[1]: Reached target Socket Units. sshClient # [ 7.045778] systemd[1]: Reached target Basic System. machine # [ 7.142789] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.144538] systemd[1]: Reached target System Initialization. sshClient # [ 7.048044] systemd[1]: Started backdoor.service. sshClient # [ 7.050075] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.150285] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.151910] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.153284] systemd[1]: Reached target Timer Units. machine # [ 7.154486] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 7.061619] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.159818] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine # [ 7.161406] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 7.163533] systemd[1]: Reached target Socket Units. machine # [ 7.164454] systemd[1]: Reached target Basic System. machine # [ 7.165577] systemd[1]: Started backdoor.service. machine # [ 7.167203] systemd[1]: Starting Import lastlog data into lastlog2 database... sshClient # [ 7.072113] systemd[1]: Starting Post-Boot Actions... sshClient # [ 7.079877] systemd[1]: Started Reset console on configuration changes. machine # [ 7.180535] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.193137] systemd[1]: Starting Post-Boot Actions... machine # [ 7.197812] systemd[1]: Started Reset console on configuration changes. sshClient # [ 7.101552] systemd[1]: Starting resolvconf update... machine # [ 7.211782] systemd[1]: Starting resolvconf update... sshClient # [ 7.117565] systemd[1]: Starting Home Area Manager... machine # [ 7.230090] systemd[1]: Starting SSH Host Keys Generation... sshClient # [ 7.150648] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.258309] systemd[1]: Starting Home Area Manager... sshClient # [ 7.169986] nsncd[505]: Oct 18 02:49:41.752 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.174259] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.176520] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 7.177481] systemd[1]: Reached target User and Group Name Lookups. sshClient # connecting to host... machine # [ 7.283374] nsncd[510]: Oct 18 02:49:41.682 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.285366] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # connecting to host... sshClient # [ 7.095904] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 7.305086] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.305980] systemd[1]: Reached target User and Group Name Lookups. sshClient # [ 7.215960] systemd[1]: Starting User Login Management... sshClient # [ 7.222783] systemd[1]: Finished Post-Boot Actions. machine # [ 7.330095] systemd[1]: Starting D-Bus System Message Bus... sshClient # [ 7.105743] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] sshClient # [ 7.340784] Console: switching to colour dummy device 80x25 sshClient # [ 7.357239] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt sshClient # [ 7.357358] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine: Guest shell says: b'Spawning backdoor root shell...\n' sshClient # [ 7.259560] systemd-homed[511]: Watching /home. machine # [ 7.358298] systemd[1]: Starting User Login Management... machine # [ 7.361483] systemd[1]: Finished Post-Boot Actions. machine: connected to guest root shell machine: (connecting took 8.00 seconds) machine: (finished: waiting for the VM to finish booting, in 8.00 seconds) sshClient # [ 7.281217] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 7.409916] systemd[1]: Finished Import lastlog data into lastlog2 database. sshClient # [ 7.442881] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 sshClient # [ 7.444130] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 7.426736] systemd-homed[518]: Watching /home. sshClient # [ 7.331146] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.368370] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... sshClient # [ 7.374356] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' sshClient # [ 7.375398] dbus-broker-launch[514]: Invalid user-name in /nix/store/9sv2j2v859bczwf3a2l1vahwdhfbinw7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" sshClient # [ 7.536219] [drm] Found bochs VGA, ID 0xb0c5. sshClient # [ 7.536222] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. sshClient # [ 7.394604] systemd[1]: Stopped target Host and Network Name Lookups. sshClient # [ 7.397249] systemd[1]: Stopping Host and Network Name Lookups... sshClient # [ 7.398109] systemd[1]: Stopped target User and Group Name Lookups. sshClient # [ 7.398987] systemd[1]: Stopping User and Group Name Lookups... sshClient # [ 7.401278] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... sshClient # [ 7.406355] systemd-logind[533]: New seat seat0. sshClient # [ 7.409904] systemd[1]: nscd.service: Deactivated successfully. sshClient # [ 7.410796] systemd[1]: Stopped Name Service Cache Daemon (nsncd). sshClient # [ 7.416131] systemd[1]: Started User Login Management. sshClient # [ 7.559211] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic sshClient # [ 7.559841] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 sshClient # [ 7.426173] systemd[1]: Starting linger-users.service... sshClient # [ 7.431158] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 7.432072] systemd[1]: Started D-Bus System Message Bus. machine # [ 7.239347] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 7.239422] rtc_cmos PNP0B00:00: setting system clock to 2026-10-18T02:49:41 UTC (1792291781) sshClient # [ 7.440052] systemd-logind[533]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) sshClient # [ 7.468685] dbus-broker-launch[514]: Ready machine # [ 7.569507] systemd[1]: Stopped target Host and Network Name Lookups. sshClient # [ 7.473943] systemd[1]: Started Home Area Manager. machine # [ 7.570483] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 7.571478] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 7.572747] systemd[1]: Stopping User and Group Name Lookups... machine # [ 7.573526] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... sshClient # [ 7.478728] systemd-logind[533]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 7.239501] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.239950] systemd-journald[282]: Time jumped backwards, rotating. machine # [ 7.265454] parport_pc 00:02: reported by Plug and Play ACPI sshClient # [ 7.492572] systemd[1]: Finished Home Area Activation. machine # [ 7.589719] systemd[1]: nscd.service: Deactivated successfully. machine # [ 7.594466] dbus-broker-launch[535]: Looking up NSS user entry for 'systemd-timesync'... sshClient # [ 7.499211] systemd[1]: Starting First Boot Home Area Wizard... machine # [ 7.596905] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 7.605280] dbus-broker-launch[535]: NSS returned no entry for 'systemd-timesync' machine # [ 7.606275] dbus-broker-launch[535]: Invalid user-name in /nix/store/1137bndjjzxnla62yshvw54kqp5sws2w-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 7.265548] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 7.268648] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 7.274277] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 7.561862] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 7.561983] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD sshClient # [ 7.719554] ppdev: user-space parallel port driver machine # [ 7.674113] Console: switching to colour dummy device 80x25 machine # [ 7.729422] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 7.732403] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 sshClient # [ 7.765085] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) sshClient # [ 7.786340] Console: switching to colour frame buffer device 160x50 sshClient # [ 7.796332] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 7.990558] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 7.990560] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. sshClient # [ 7.894407] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device sshClient # [ 7.532927] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 7.627774] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.852669] systemd[1]: Starting Virtual Console Setup... machine # [ 7.853583] systemd[1]: Started D-Bus System Message Bus. sshClient # [ 7.758299] nsncd[587]: Oct 18 02:49:42.124 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.859127] dbus-broker-launch[535]: Ready sshClient # [ 7.762475] systemd[1]: Finished linger-users.service. sshClient # [ 7.764319] network-addresses-eth1-start[617]: adding address 192.168.1.2/24... done sshClient # [ 7.767141] network-addresses-eth1-start[617]: adding address 2001:db8:1::2/64... done machine # [ 7.860032] nsncd[605]: Oct 18 02:49:42.149 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.866079] systemd[1]: Started Home Area Manager. machine # [ 7.866870] systemd[1]: Finished Home Area Activation. machine # [ 7.867570] systemd[1]: Starting First Boot Home Area Wizard... sshClient # [ 7.771750] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.773326] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.870170] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.871298] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.872236] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.874119] systemd[1]: Finished resolvconf update. sshClient # [ 7.777560] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.874875] systemd[1]: Reached target Preparation for Network. machine # [ 7.875837] systemd[1]: Starting DHCP Client... machine # [ 7.876535] systemd[1]: Starting Address configuration of eth1... machine # [ 7.878347] systemd[1]: Starting Extra networking commands.... machine # [ 7.879364] systemd-logind[538]: New seat seat0. machine # [ 8.023989] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic sshClient # [ 7.784345] systemd[1]: Finished resolvconf update. machine # [ 8.024668] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 sshClient # [ 7.785131] systemd[1]: Reached target Preparation for Network. sshClient # [ 7.785875] systemd[1]: Starting DHCP Client... sshClient # [ 7.786534] systemd[1]: Starting Address configuration of eth1... machine # [ 7.883242] systemd[1]: Started User Login Management. sshClient # [ 7.787364] systemd[1]: Starting Extra networking commands.... sshClient # [ 7.790200] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) sshClient # [ 7.791379] systemd[1]: Finished Address configuration of eth1. sshClient # [ 7.792196] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.793114] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 7.806323] systemd[1]: Starting Virtual Console Setup... machine # [ 7.904625] systemd-logind[538]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 7.908456] systemd-logind[538]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 7.923833] systemd[1]: Starting linger-users.service... machine # [ 7.946184] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.856263] dhcpcd[625]: dhcpcd-10.3.2 starting machine # [ 7.955379] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 7.860897] systemd[1]: Finished First Boot Home Area Wizard. sshClient # [ 7.863190] systemd[1]: Reached target First Boot Complete. sshClient # [ 7.869137] systemd[1]: Starting Save Transient machine-id to Disk... sshClient # [ 7.872425] dhcpcd[683]: dev: loaded udev sshClient # [ 7.893240] systemd[1]: Finished Extra networking commands.. sshClient # [ 7.893993] systemd[1]: Reached target Network. machine # [ 7.997067] systemd[1]: Starting Virtual Console Setup... machine # [ 8.158759] ppdev: user-space parallel port driver machine # [ 8.170230] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) sshClient # [ 7.931287] systemd[1]: Starting Permit User Sessions... sshClient # [ 8.077215] 8021q: 802.1Q VLAN Support v1.8 sshClient # [ 8.077628] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.033208] network-addresses-eth1-start[629]: adding address 192.168.1.1/24... done machine # [ 8.059553] network-addresses-eth1-start[629]: adding address 2001:db8:1::1/64... done machine # [ 8.060787] systemd[1]: Created slice Slice /system/systemd-mute-console. machine # [ 8.071834] systemd[1]: Started Console Output Muting Service (PID 614/UID 0). machine # [ 8.072808] systemd[1]: linger-users.service: Deactivated successfully. sshClient # [ 8.128724] kvm_amd: TSC scaling supported machine # [ 8.083059] systemd[1]: Finished linger-users.service. sshClient # [ 8.131114] kvm_amd: Nested Virtualization enabled sshClient # [ 8.131621] kvm_amd: Nested Paging enabled sshClient # [ 8.131999] kvm_amd: LBR virtualization supported sshClient # [ 8.136105] kvm_amd: Virtual VMLOAD VMSAVE supported sshClient # [ 8.136613] kvm_amd: Virtual GIF supported sshClient # [ 8.136994] kvm_amd: Virtual NMI enabled sshClient # [ 8.001695] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 8.099048] systemd-logind[538]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) sshClient # [ 8.012266] systemd[1]: Finished Permit User Sessions. sshClient # [ 8.020420] systemd[1]: Started Getty on tty1. sshClient # [ 8.021107] systemd[1]: Reached target Login Prompts. sshClient # [ 8.212336] cfg80211: Loading compiled-in X.509 certificates for regulatory database sshClient # [ 8.213873] EDAC MC: Ver: 3.0.0 sshClient # [ 8.078487] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. sshClient # [ 8.083790] systemd[1]: Finished Save Transient machine-id to Disk. sshClient # [ 8.234989] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' sshClient # [ 8.235734] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' sshClient # [ 8.237799] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 sshClient # [ 8.238675] cfg80211: failed to load regulatory.db sshClient # [ 8.268566] 8021q: adding VLAN 0 to HW filter on device eth0 sshClient # [ 8.127662] dhcpcd[683]: eth0: waiting for carrier sshClient # [ 8.128600] dhcpcd[683]: eth0: carrier acquired sshClient # [ 8.133741] dhcpcd[683]: DUID 00:01:00:01:32:66:f0:46:52:54:00:12:34:56 sshClient # [ 8.134763] dhcpcd[683]: eth0: IAID 00:12:34:56 sshClient # [ 8.135567] dhcpcd[683]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 8.117935] systemd[1]: Finished Address configuration of eth1. machine # [ 8.266204] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.269877] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.271656] dhcpcd[646]: dhcpcd-10.3.2 starting sshClient # [ 8.177458] systemd-vconsole-setup[674]: Configuration of first virtual console was skipped, ignoring remaining ones. sshClient # [ 8.180366] systemd[1]: Finished Virtual Console Setup. machine # [ 8.287251] dhcpcd[703]: dev: loaded udev machine # [ 8.290204] systemd[1]: Starting Virtual Console Setup... machine # [ 8.308645] systemd[1]: Finished Extra networking commands.. machine # [ 8.309939] systemd[1]: Reached target Network. machine # [ 8.460094] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine: (finished: waiting for unit systemd-homed.service, in 9.26 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.08 seconds) machine: sending keys 'test-homed-user\n' machine # [ 8.723688] dhcpcd[703]: eth0: waiting for carrier machine # [ 8.724709] dhcpcd[703]: libudev: received NULL device machine # [ 8.727182] dhcpcd[703]: libudev: received NULL device machine # [ 8.728060] dhcpcd[703]: eth0: carrier acquired machine # [ 8.749428] dhcpcd[703]: DUID 00:01:00:01:32:66:f0:47:52:54:00:12:34:56 machine # [ 8.750412] dhcpcd[703]: eth0: IAID 00:12:34:56 machine # [ 8.751108] dhcpcd[703]: eth0: adding address fe80::5054:ff:fe12:3456 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 # [ 8.937326] sshd-keygen-start[560]: Generating public/private rsa key pair. machine # [ 8.938840] sshd-keygen-start[560]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine # [ 8.940428] sshd-keygen-start[560]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine # [ 8.941636] sshd-keygen-start[560]: The key fingerprint is: machine # [ 8.942411] sshd-keygen-start[560]: SHA256:IvwJEZJM3IMovXZXKWmByj1GLMtJoHtSsTr2qSv0bec root@machine machine # [ 8.943598] sshd-keygen-start[560]: The key's randomart image is: machine # [ 8.944408] sshd-keygen-start[560]: +---[RSA 4096]----+ machine # [ 8.945130] sshd-keygen-start[560]: |.B+=...o . | machine # [ 8.945794] sshd-keygen-start[560]: |+ O+*.+ o | machine # [ 8.946478] sshd-keygen-start[560]: |o+oO.o o | machine # [ 8.947204] sshd-keygen-start[560]: | +O.=.. | machine # [ 8.947901] sshd-keygen-start[560]: |=o.o+o. S | machine # [ 8.950256] sshd-keygen-start[560]: |.=. .+ o | machine # [ 8.950971] sshd-keygen-start[560]: |. .o. o | machine # [ 8.952104] sshd-keygen-start[560]: |. .. o . | machine # [ 8.952811] sshd-keygen-start[560]: |.o. . oE | machine # [ 8.954265] sshd-keygen-start[560]: +----[SHA256]-----+ machine # [ 8.983302] sshd-keygen-start[745]: Generating public/private ed25519 key pair. machine # [ 8.984332] sshd-keygen-start[745]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine # [ 8.985588] sshd-keygen-start[745]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine # [ 8.986746] sshd-keygen-start[745]: The key fingerprint is: machine # [ 8.987513] sshd-keygen-start[745]: SHA256:dlQGOg9OAi8C2iyNQ+bHHrFwHa8CeN+i831S8VMHV9A root@machine machine # [ 8.988748] sshd-keygen-start[745]: The key's randomart image is: machine # [ 8.989538] sshd-keygen-start[745]: +--[ED25519 256]--+ machine # [ 8.990197] sshd-keygen-start[745]: |.+ oo.. ..o .+.| machine # [ 8.990915] sshd-keygen-start[745]: |**+ o+. . o. . E| machine # [ 8.991550] sshd-keygen-start[745]: |*o*=. o.= . o | machine # [ 8.992226] sshd-keygen-start[745]: | ++o.o.+.= . . | machine # [ 8.992885] sshd-keygen-start[745]: | oo.. Soo. . | machine # [ 8.993556] sshd-keygen-start[745]: | ... ...o | machine # [ 8.994296] sshd-keygen-start[745]: | o . . | machine # [ 8.995036] sshd-keygen-start[745]: | o .. . | machine # [ 8.995717] sshd-keygen-start[745]: | . .o | machine # [ 8.996380] sshd-keygen-start[745]: +----[SHA256]-----+ machine # [ 8.999759] systemd[1]: sshd-keygen.service: Deactivated successfully. machine # [ 9.001193] systemd[1]: Finished SSH Host Keys Generation. machine # [ 9.005103] systemd[1]: Starting SSH Daemon... machine # [ 9.036761] sshd[747]: Server listening on 0.0.0.0 port 22. machine # [ 9.038156] systemd[1]: Started SSH Daemon. machine # [ 9.038815] sshd[747]: Server listening on :: port 22. machine # [ 9.043381] systemd-vconsole-setup[705]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 9.046230] systemd[1]: Finished Virtual Console Setup. machine # [ 9.362772] dhcpcd[703]: eth0: soliciting a DHCP lease machine # [ 9.374387] dhcpcd[703]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.377233] dhcpcd[703]: eth0: probing address 10.0.2.15/24 sshClient # [ 9.737665] dhcpcd[683]: eth0: soliciting a DHCP lease sshClient # [ 9.887920] NET: Registered PF_PACKET protocol family sshClient # [ 9.751979] dhcpcd[683]: eth0: offered 10.0.2.15 from 10.0.2.2 sshClient # [ 9.754223] dhcpcd[683]: eth0: probing address 10.0.2.15/24 machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.14 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.264303] dhcpcd[703]: eth0: soliciting an IPv6 router machine # [ 10.265654] dhcpcd[703]: eth0: Router Advertisement from fe80::2 machine # [ 10.266492] dhcpcd[703]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 10.267379] dhcpcd[703]: eth0: adding route to fec0::/64 machine # [ 10.268159] dhcpcd[703]: eth0: adding default route via fe80::2 sshClient # [ 10.616655] dhcpcd[683]: eth0: soliciting an IPv6 router sshClient # [ 10.619333] dhcpcd[683]: eth0: Router Advertisement from fe80::2 sshClient # [ 10.621718] dhcpcd[683]: eth0: adding address fec0::5054:ff:fe12:3456/64 sshClient # [ 10.624108] dhcpcd[683]: eth0: adding route to fec0::/64 sshClient # [ 10.625978] dhcpcd[683]: eth0: adding default route via fe80::2 machine: (finished: waiting for (repeat) to appear on tty 1, in 1.07 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 # [ 15.006687] dhcpcd[683]: eth0: leased 10.0.2.15 for 86400 seconds sshClient # [ 15.009715] dhcpcd[683]: eth0: adding route to 10.0.2.0/24 sshClient # [ 15.012293] dhcpcd[683]: eth0: adding default route via 10.0.2.2 machine # [ 15.153475] dhcpcd[703]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 15.155599] dhcpcd[703]: eth0: adding route to 10.0.2.0/24 machine # [ 15.158559] dhcpcd[703]: eth0: adding default route via 10.0.2.2 sshClient # [ 15.097238] systemd[1]: Started DHCP Client. sshClient # [ 15.099473] systemd[1]: Reached target Multi-User System. sshClient # [ 15.100457] systemd[1]: Startup finished in 847ms (kernel) + 3.983s (initrd) + 10.269s (userspace) = 15.100s. machine # [ 15.238619] systemd[1]: Started DHCP Client. machine # [ 21.465542] systemd-homed[518]: Generating key pair for signing local user identity records. machine # [ 21.469853] systemd-homed[518]: Successfully created Ed25519 key pair. machine # [ 21.487068] systemd-homed[518]: test-homed-user: changing state absent → creating machine # [ 21.557114] systemd-homework[872]: Using automatic default storage of 'luks'. machine # [ 21.561488] systemd-homework[872]: Sizing home to 83% of available disk space, which is 743M. machine # [ 21.562781] systemd-homework[872]: Allocating image file completed. machine # [ 21.582367] systemd-homework[872]: Writing of partition table completed. machine # [ 21.586909] systemd-homework[872]: Setting up loopback device /dev/loop0 completed. machine # [ 22.936328] systemd-homework[872]: LUKS formatting completed. machine # [ 24.600310] systemd-homework[872]: Writing password to LUKS keyslot 0 completed. machine # [ 24.793126] systemd-homework[872]: LUKS activation by volume key succeeded. machine # [ 24.812208] systemd-homework[872]: Writing user record as LUKS token completed. machine # [ 24.813241] systemd-homework[872]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 24.814604] systemd-homework[872]: Formatting /dev/mapper/home-test-homed-user as btrfs machine # [ 25.162863] systemd[1]: proc-901-mounts.mount: Deactivated successfully. machine # [ 25.164294] systemd-homework[872]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid 04837aeb-6341-4fde-a57a-1721c51e7017) machine # [ 25.166376] systemd-homework[872]: Formatting file system completed. machine # [ 25.198758] systemd-homework[872]: Mounting file system completed. machine # [ 25.201065] systemd-homework[872]: Skeleton directory /etc/skel missing, ignoring. machine # [ 25.202113] systemd-homework[872]: Wrote embedded .identity file. machine # [ 25.203092] systemd-homework[872]: Replaced embedded blob dir with contents of system blob dir. machine # [ 25.204416] systemd-homework[872]: Recursive changing of ownership completed. machine # [ 25.205663] systemd-homework[872]: Changed top-level directory access mode to 0700. machine # [ 25.251945] systemd-homework[872]: Synchronized disk. machine # [ 25.253282] systemd-homework[872]: Discarded unused 651.8M. machine # [ 25.262096] systemd-homed[518]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 25.271066] systemd-homed[518]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 25.285824] (udev-worker)[893]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 25.288497] (udev-worker)[893]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 25.290793] (udev-worker)[893]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 25.293325] systemd-homed[518]: block device /sys/devices/virtual/block/loop0 has been removed. machine # [ 25.298520] systemd-homework[872]: Moved image file into place. machine # [ 25.299416] systemd-homework[872]: Creation completed. machine # [ 25.300159] 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.307771] systemd-homed[518]: test-homed-user: changing state creating → inactive machine # [ 25.313234] systemd[1]: systemd-mute-console@0-1-614_615-0.service: Deactivated successfully. machine # [ 25.316272] systemd[1]: Finished First Boot Home Area Wizard. machine # [ 25.320081] systemd[1]: Reached target First Boot Complete. machine # [ 25.323171] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 25.325362] systemd[1]: Starting Permit User Sessions... machine # [ 25.348125] systemd[1]: Finished Permit User Sessions. machine # [ 25.352307] systemd[1]: Started Getty on tty1. machine # [ 25.355102] systemd[1]: Reached target Login Prompts. machine # [ 25.356276] systemd[1]: Reached target Multi-User System. machine # [ 25.395114] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 25.397503] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 25.399853] systemd[1]: Startup finished in 858ms (kernel) + 4.035s (initrd) + 20.505s (userspace) = 25.399s. machine: (finished: waiting for unit systemd-homed-firstboot.service, in 14.88 seconds) (finished: subtest: create systemd-homed user on first boot prompt, in 26.81 seconds) machine: must succeed: homectl update test-homed-user --offline -G wheel machine # [ 26.216278] systemd-homed[518]: test-homed-user: changing state inactive → updating machine # [ 26.220885] systemd-homework[947]: Offline update requested. Not touching embedded records. machine # [ 26.223315] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 26.230083] systemd-homed[518]: test-homed-user: changing state updating → inactive machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.05 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.16 seconds) machine: waiting for Password: to appear on tty 1 machine # [ 26.581711] systemd-homed[518]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 26.585945] systemd-homework[962]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 26.592517] systemd-homed[518]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 26.594178] systemd-homed[518]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 26.595350] systemd-homed[518]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 26.596740] 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.11 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.716597] systemd-homed[518]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 27.755526] systemd-homework[974]: Provided password unlocks user record. machine # [ 27.759330] systemd-homework[974]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 27.764471] systemd-homework[974]: Allocated additional 651.8M. machine # [ 27.912076] loop1: detected capacity change from 0 to 1517568 machine # [ 27.769664] systemd-homework[974]: Setting up loopback device /dev/loop1 completed. machine # [ 28.592094] systemd-homework[974]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 28.616177] systemd-homework[974]: Provided password unlocks user record. machine # [ 28.621481] systemd-homework[974]: Probing file system completed (found btrfs). machine # [ 28.623510] systemd-homework[974]: No fsck for file system btrfs installed, ignoring. machine # [ 28.769150] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (974) machine # [ 28.771653] BTRFS info (device dm-0): first mount of filesystem 04837aeb-6341-4fde-a57a-1721c51e7017 machine # [ 28.772523] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 28.776852] BTRFS info (device dm-0): enabling free space tree machine # [ 28.777467] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 28.634724] systemd-homework[974]: Mounting file system completed. machine # [ 28.636348] systemd-homework[974]: Discovered used loopback device /dev/loop1. machine # [ 28.637407] systemd-homework[974]: offset = 1048576, size = 776994816, image = 779091968 machine # [ 28.646814] systemd-homework[974]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M. machine # [ 28.648568] systemd-homework[974]: Growing of image file from 743M to 896M completed. machine # [ 28.795648] loop1: detected capacity change from 1517568 to 1830912 machine # [ 28.652701] systemd-homework[974]: Refreshing loop device size completed. machine # [ 28.666404] systemd-homework[974]: Growing of partition completed. machine # [ 28.827421] async_tx: api initialized (async) machine # [ 28.731546] systemd-homework[974]: LUKS device growing completed. machine # [ 28.882688] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 920649728 machine # [ 28.740308] systemd-homework[974]: File system resizing from 725M to 878M completed. machine # [ 28.743056] systemd-homework[974]: Synchronized disk. machine # [ 28.743787] systemd-homework[974]: Synchronized disk. machine # [ 28.744452] systemd-homework[974]: Resizing completed. machine # [ 28.745194] systemd-homework[974]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 28.746774] systemd-homework[974]: Read embedded .identity file. machine # [ 28.765160] systemd-homework[974]: Provided password unlocks user record. machine # [ 28.766189] systemd-homework[974]: Reconciling header user identity completed (host version was newer). machine # [ 28.767931] systemd-homework[974]: Reconciling embedded user identity completed (host version was newer). machine # [ 28.783929] systemd-homework[974]: Wrote LUKS header user record. machine # [ 28.785069] systemd-homework[974]: Wrote embedded .identity file. machine # [ 28.786243] systemd-homework[974]: Replaced embedded blob dir with contents of system blob dir. machine # [ 28.787438] systemd-homework[974]: Recursive changing of ownership not necessary, skipped. machine # [ 28.794563] systemd-homework[974]: Synchronized disk. machine # [ 28.796511] systemd-homework[974]: Moving to final mount point /home/test-homed-user completed. machine # [ 28.818903] systemd-homework[974]: Activation completed. machine # [ 28.820627] systemd-homework[974]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 28.830541] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 28.839564] login[938]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired. machine # [ 28.841583] systemd-homed[518]: test-homed-user: changing state activating-for-acquire → active machine # [ 28.849874] systemd-homed[518]: test-homed-user: changing state active → resizing-while-active machine # [ 28.861645] systemd-homework[1016]: Successfully acquired home volume key from kernel keyring. machine # [ 28.863411] systemd-homework[1016]: LUKS volume key from keyring unlocks user record. machine # [ 28.915519] login[938]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0) machine # [ 28.947138] systemd-homework[1016]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 28.968149] systemd[1]: Created slice Slice /user/60388. machine # [ 28.970210] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 28.984349] systemd-logind[538]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'. machine # [ 29.036619] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 29.050199] systemd[1]: Starting User Manager for UID 60388... machine # [ 29.094433] (systemd)[1022]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 29.149697] (systemd)[1022]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 29.153747] systemd-logind[538]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 29.198066] systemd[1022]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.232075] systemd-homework[1016]: Successfully re-activated LUKS device. machine # [ 29.237063] systemd-homework[1016]: LUKS volume key from keyring unlocks user record. machine # [ 29.238123] systemd-homework[1016]: Discovered used loopback device /dev/loop1. machine # [ 29.239093] systemd-homework[1016]: Read embedded .identity file. machine # [ 29.239915] systemd-homework[1016]: LUKS volume key from keyring unlocks user record. machine # [ 29.240934] systemd-homework[1016]: Reconciling header user identity completed (host version was newer). machine # [ 29.242117] systemd-homework[1016]: Reconciling embedded user identity completed (host version was newer). machine # [ 29.243313] systemd-homework[1016]: offset = 1048576, size = 937426944, image = 939524096 machine # [ 29.260554] systemd-homework[1016]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M. machine # [ 29.262525] systemd-homework[1016]: Wrote embedded .identity file. machine # [ 29.263634] systemd-homework[1016]: Replaced embedded blob dir with contents of system blob dir. machine # [ 29.265162] systemd-homework[1016]: Backing file is fully allocated already. machine # [ 29.412441] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 782237696 machine # [ 29.270321] systemd-homework[1016]: File system resizing from 878M to 746M completed. machine # [ 29.278231] systemd-homework[1016]: Synchronized disk. machine # [ 29.326850] systemd-homework[1016]: LUKS device shrinking completed. machine # [ 29.472723] loop1: detected capacity change from 1830912 to 1560576 machine # [ 29.334629] systemd-homework[1016]: Refreshing loop device size completed. machine # [ 29.335610] systemd-homework[1016]: Shrinking of image file completed. machine # [ 29.355477] systemd-homework[1016]: Shrinking of partition completed. machine # [ 29.366298] systemd[1022]: Queued start job for default target Main User Target. machine # [ 29.368934] systemd[1022]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.377258] systemd-homework[1016]: Wrote LUKS header user record. machine # [ 29.378200] systemd-homework[1016]: Synchronized disk. machine # [ 29.381067] systemd[1022]: Created slice User Application Slice. machine # [ 29.381985] systemd[1022]: Started Daily Cleanup of User's Temporary Directories. machine # [ 29.390184] systemd[1022]: Reached target Paths. machine # [ 29.390988] systemd[1022]: Reached target Timers. machine # [ 29.395528] systemd-homework[1016]: Resizing completed. machine # [ 29.397139] systemd-homework[1016]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 29.398697] systemd[1022]: Starting D-Bus User Message Bus Socket... machine # [ 29.399652] systemd[1022]: Starting Create User Files and Directories... machine # [ 29.406153] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 29.418636] systemd-homed[518]: test-homed-user: changing state resizing-while-active → active machine # [ 29.420217] systemd-homed[518]: Rebalancing complete. machine # [ 29.430441] systemd[1022]: Finished Create User Files and Directories. machine # [ 29.444869] systemd[1022]: Listening on D-Bus User Message Bus Socket. machine # [ 29.446719] systemd[1022]: Reached target Sockets. machine # [ 29.447485] systemd[1022]: Reached target Basic System. machine # [ 29.448247] systemd[1]: Started User Manager for UID 60388. machine # [ 29.452235] systemd[1022]: Starting Run user-specific NixOS activation... machine # [ 29.457086] systemd[1]: Started Session 1 of User test-homed-user. machine # [ 29.484960] systemd[1022]: Finished Run user-specific NixOS activation. machine # [ 29.486461] systemd[1022]: Reached target Main User Target. machine # [ 29.487755] systemd[1022]: Startup finished in 308ms. machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.16 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.08 seconds) machine: must succeed: cat /tmp/2 machine: (finished: must succeed: cat /tmp/2, in 0.03 seconds) (finished: subtest: login as homed user, in 4.84 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.03 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.09 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.478877] login[692]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0) sshClient # [ 32.515943] systemd[1]: Created slice Slice /user/1000. sshClient # [ 32.519162] systemd[1]: Starting User Runtime Directory /run/user/1000... sshClient # [ 32.533405] systemd-logind[533]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'. sshClient # [ 32.561246] systemd[1]: Finished User Runtime Directory /run/user/1000. sshClient # [ 32.564508] systemd[1]: Starting User Manager for UID 1000... sshClient # [ 32.593333] (systemd)[810]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0) sshClient # [ 32.600336] systemd-logind[533]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'. sshClient # [ 32.618247] systemd[810]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 32.707795] systemd[810]: Queued start job for default target Main User Target. sshClient # [ 32.711687] systemd[810]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 32.714258] systemd[810]: Created slice User Application Slice. sshClient # [ 32.716149] systemd[810]: Started Daily Cleanup of User's Temporary Directories. sshClient # [ 32.717113] systemd[810]: Reached target Paths. sshClient # [ 32.717844] systemd[810]: Reached target Timers. sshClient # [ 32.719221] systemd[810]: Starting D-Bus User Message Bus Socket... sshClient # [ 32.721880] systemd[810]: Starting Create User Files and Directories... sshClient # [ 32.750230] systemd[810]: Finished Create User Files and Directories. sshClient # [ 32.767064] systemd[810]: Listening on D-Bus User Message Bus Socket. sshClient # [ 32.768027] systemd[810]: Reached target Sockets. sshClient # [ 32.768712] systemd[810]: Reached target Basic System. sshClient # [ 32.770068] systemd[1]: Started User Manager for UID 1000. sshClient # [ 32.772745] systemd[810]: Starting Run user-specific NixOS activation... sshClient # [ 32.775796] systemd[1]: Started Session 1 of User test-normal-user. sshClient # [ 32.813460] systemd[810]: Finished Run user-specific NixOS activation. sshClient # [ 32.814523] systemd[810]: Reached target Main User Target. sshClient # [ 32.816303] systemd[810]: Startup finished in 200ms. sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.08 seconds) sshClient: sending keys 'whoami > /tmp/1\n' sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.16 seconds) sshClient: waiting for file '/tmp/1' sshClient: (finished: waiting for file '/tmp/1', in 1.04 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.69 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.48 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 AAAAC3NzaC1lZDI1NTE5AAAAIMTW9KvhDyNquMs9jXF9afiDUUC4CCDwL26VfXMFXwxJ test-normal-user@sshClient' machine # [ 36.365407] systemd-homed[518]: test-homed-user: changing state active → updating-while-active machine # [ 36.374871] systemd-homework[1073]: Offline update requested. Not touching embedded records. machine # [ 36.387074] 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 AAAAC3NzaC1lZDI1NTE5AAAAIMTW9KvhDyNquMs9jXF9afiDUUC4CCDwL26VfXMFXwxJ test-normal-user@sshClient', in 0.07 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.03 seconds) (finished: subtest: add homed ssh authorized key, in 1.66 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.09 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.10 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/2bhsk8wfsfr8v5d88sjwrmfb3mv2fxwa-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.205149] systemd-homed[518]: test-homed-user: changing state active → passwd-while-active machine # [ 39.913157] systemd-homework[1112]: No valid password for LUKS superblock. machine # [ 42.221870] systemd-homed[518]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 42.226634] 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.344382] systemd-homed[518]: test-homed-user: changing state active → passwd-while-active machine # [ 44.705760] systemd-homework[1118]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 44.846039] systemd-homework[1118]: Successfully re-activated LUKS device. machine # [ 44.888128] systemd-homework[1118]: Provided password unlocks user record. machine # [ 44.890166] systemd-homework[1118]: Discovered used loopback device /dev/loop1. machine # [ 44.891147] systemd-homework[1118]: Read embedded .identity file. machine # [ 44.929442] systemd-homework[1118]: Provided password unlocks user record. machine # [ 44.930551] systemd-homework[1118]: Reconciling header user identity completed (host version was newer). machine # [ 44.931826] systemd-homework[1118]: Reconciling embedded user identity completed (host version was newer). machine # [ 48.163693] systemd-homework[1118]: Added LUKS key slot 1. machine # [ 48.193504] systemd-homework[1118]: Destroyed LUKS key slot 0. machine # [ 48.205929] systemd-homework[1118]: Wrote LUKS header user record. machine # [ 48.207134] systemd-homework[1118]: Wrote embedded .identity file. machine # [ 48.208140] systemd-homework[1118]: Replaced embedded blob dir with contents of system blob dir. machine # [ 48.214533] systemd-homework[1118]: Synchronized disk. machine # [ 48.218081] systemd-homework[1118]: Everything completed. machine # [ 48.229935] passwd[1086]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user. machine # [ 48.232473] 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.93 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.829742] systemd-homed[518]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 48.837483] systemd-homework[1157]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 48.846242] systemd-homed[518]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 48.850243] 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.10 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.01 seconds) machine: waiting for success: grep uid=0 /tmp/4 machine # [ 49.861399] systemd-homed[518]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 49.884570] systemd-homework[1173]: Provided password unlocks user record. machine # [ 50.499432] systemd-homework[1173]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 50.624078] systemd-homework[1173]: Successfully re-activated LUKS device. machine # [ 50.646882] systemd-homework[1173]: Provided password unlocks user record. machine # [ 50.648331] systemd-homework[1173]: Discovered used loopback device /dev/loop1. machine # [ 50.649463] systemd-homework[1173]: Read embedded .identity file. machine # [ 50.668975] systemd-homework[1173]: Provided password unlocks user record. machine # [ 50.670136] systemd-homework[1173]: Reconciling user identities completed (host and header version were identical). machine # [ 50.671439] systemd-homework[1173]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 50.681109] systemd-homework[1173]: Everything completed. machine # [ 50.686439] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 50.693371] sudo[1155]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired. machine # [ 50.695601] systemd-homed[518]: test-homed-user: changing state authenticating-for-acquire → active machine # [ 50.699653] sudo[1155]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id machine # [ 50.709807] sudo[1155]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388) machine # [ 50.717057] sudo[1155]: pam_unix(sudo:session): session closed for user root machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.03 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 # [ 50.910520] login[938]: pam_unix(login:session): session closed for user test-homed-user machine # [ 50.914652] login[938]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 50.925755] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 50.934250] systemd[1]: session-1.scope: Deactivated successfully. machine # [ 50.937521] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. machine # [ 50.940253] systemd-logind[538]: Session 1 logged out. Waiting for processes to exit. machine # [ 50.944840] systemd[1]: Started Getty on tty1. machine # [ 50.946887] systemd-logind[538]: Removed session 1. machine # [ 61.181750] systemd[1]: Stopping User Manager for UID 60388... machine # [ 61.187580] systemd[1022]: Activating special unit Exit the Session... machine # [ 61.191880] systemd[1022]: Stopped target Main User Target. machine # [ 61.195648] systemd[1022]: Stopped Run user-specific NixOS activation. machine # [ 61.197832] systemd[1022]: Stopped target Basic System. machine # [ 61.201860] systemd[1022]: Stopped target Paths. machine # [ 61.205995] systemd[1022]: Stopped target Sockets. machine # [ 61.209658] systemd[1022]: Stopped target Timers. machine # [ 61.212813] systemd[1022]: Stopped Daily Cleanup of User's Temporary Directories. machine # [ 61.216352] systemd[1022]: Closed D-Bus User Message Bus Socket. machine # [ 61.220718] systemd[1022]: Stopped Create User Files and Directories. machine # [ 61.223287] systemd[1022]: Removed slice User Application Slice. machine # [ 61.225387] systemd[1022]: Reached target Shutdown. machine # [ 61.228560] systemd[1022]: Finished Exit the Session. machine # [ 61.230395] systemd[1022]: Reached target Exit the Session. machine # [ 61.235728] systemd-logind[538]: Removed session 2. machine # [ 61.240986] systemd-homed[518]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 61.247542] systemd-homed[518]: test-homed-user: changing state active → deactivating machine # [ 61.249299] systemd[1]: user@60388.service: Deactivated successfully. machine # [ 61.253688] systemd[1]: Stopped User Manager for UID 60388. machine # [ 61.254778] systemd-homework[1249]: Successfully acquired home volume key from kernel keyring. machine # [ 61.258840] systemd-homework[1249]: Discarded unused 673.5M. machine # [ 61.269053] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully. machine # [ 61.275201] systemd[1]: Stopping User Runtime Directory /run/user/60388... machine # [ 61.303746] systemd[1]: run-user-60388.mount: Deactivated successfully. machine # [ 61.305981] systemd-homework[1249]: Syncing completed. machine # [ 61.308753] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully. machine # [ 61.312407] systemd[1]: Stopped User Runtime Directory /run/user/60388. machine # [ 61.362867] systemd-homework[1249]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 61.489203] systemd-homework[1249]: Successfully re-activated LUKS device. machine # [ 61.490762] systemd-homework[1249]: Discovered used loopback device /dev/loop1. machine # [ 61.491788] systemd-homework[1249]: offset = 1048576, size = 799014912, image = 801112064 machine # [ 61.504246] systemd-homework[1249]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M. machine # [ 61.506511] systemd-homework[1249]: Allocated additional 673.5M. machine # [ 61.656763] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 268435456 machine # [ 61.514450] systemd-homework[1249]: File system resizing from 746M to 256M completed. machine # [ 61.515913] systemd-homework[1249]: Synchronized disk. machine # [ 61.604109] systemd-homework[1249]: LUKS device shrinking completed. machine # [ 61.749565] loop1: detected capacity change from 1560576 to 557056 machine # [ 61.609269] systemd-homework[1249]: Refreshing loop device size completed. machine # [ 61.611197] systemd-homework[1249]: Shrinking of image file completed. machine # [ 61.628250] systemd-homework[1249]: Shrinking of partition completed. machine # [ 61.772785] BTRFS info (device dm-0): last unmount of filesystem 04837aeb-6341-4fde-a57a-1721c51e7017 machine # [ 61.630351] systemd-homework[1249]: Synchronized disk. machine # [ 61.631100] systemd-homework[1249]: Resizing completed. machine # [ 61.631821] systemd-homework[1249]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M. machine # [ 61.635100] systemd-homework[1249]: Unmounting completed. machine # [ 61.636321] systemd-homework[1249]: Discovered used LUKS device /dev/mapper/home-test-homed-user. machine # [ 61.638245] systemd-homework[1249]: Device home-test-homed-user is not active. machine # [ 61.650471] systemd-homed[518]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 61.655052] systemd-homework[1249]: Everything completed. machine # [ 61.663511] 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.48 seconds) (finished: subtest: log out and deactivate homed user's home area, in 11.54 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.178564] systemd-homed[518]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 64.187984] systemd-homework[1281]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 64.198598] systemd-homed[518]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 64.203389] sshd-session[1277]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error machine # [ 64.207721] sshd-session[1277]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation. machine # [ 64.212418] systemd-homed[518]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 64.214850] systemd-homed[518]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 64.217700] systemd-homed[518]: Home test-homed-user already deactivated, no automatic deactivation needed. machine # [ 64.220023] sshd-session[1277]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 50666 ssh2: ED25519 SHA256:kHTEr8/gfEtcAKxGrMVLE+Ksw+hc19edi77KE7tkb/w machine # [ 64.260928] sshd-session[1277]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 64.276274] systemd-logind[538]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'. machine # [ 64.279503] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 64.300750] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 64.305664] systemd[1]: Started Session 3 of User test-homed-user. machine # [ 64.321956] sshd-session[1277]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 64.325138] sshd-session[1277]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 64.340806] systemd-homed[518]: test-homed-user: changing state inactive → activating machine # [ 64.345508] systemd-homework[1286]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 64.352437] systemd-homed[518]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 64.354566] 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.16 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.599280] systemd-homed[518]: test-homed-user: changing state inactive → activating machine # [ 65.650300] systemd-homework[1291]: Provided password unlocks user record. machine # [ 65.653980] systemd-homework[1291]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 65.657995] systemd-homework[1291]: Backing file is fully allocated already. machine # [ 65.804475] loop1: detected capacity change from 0 to 557056 machine # [ 65.662124] systemd-homework[1291]: Setting up loopback device /dev/loop1 completed. machine # [ 66.516078] systemd-homework[1291]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 66.539556] systemd-homework[1291]: Provided password unlocks user record. machine # [ 66.545469] systemd-homework[1291]: Probing file system completed (found btrfs). machine # [ 66.546818] systemd-homework[1291]: No fsck for file system btrfs installed, ignoring. machine # [ 66.692600] BTRFS: device label test-homed-user devid 1 transid 18 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1291) machine # [ 66.695142] BTRFS info (device dm-0): first mount of filesystem 04837aeb-6341-4fde-a57a-1721c51e7017 machine # [ 66.696050] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 66.700734] BTRFS info (device dm-0): enabling free space tree machine # [ 66.701337] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 66.558714] systemd-homework[1291]: Mounting file system completed. machine # [ 66.560477] systemd-homework[1291]: Discovered used loopback device /dev/loop1. machine # [ 66.561566] systemd-homework[1291]: offset = 1048576, size = 285212672, image = 287309824 machine # [ 66.571138] systemd-homework[1291]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M. machine # [ 66.573317] systemd-homework[1291]: Growing of image file from 274M to 764M completed. machine # [ 66.720535] loop1: detected capacity change from 557056 to 1560576 machine # [ 66.577692] systemd-homework[1291]: Refreshing loop device size completed. machine # [ 66.592528] systemd-homework[1291]: Growing of partition completed. machine # [ 66.616308] systemd-homework[1291]: LUKS device growing completed. machine # [ 66.767315] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 782237696 machine # [ 66.625070] systemd-homework[1291]: File system resizing from 256M to 746M completed. machine # [ 66.627059] systemd-homework[1291]: Synchronized disk. machine # [ 66.627806] systemd-homework[1291]: Synchronized disk. machine # [ 66.628508] systemd-homework[1291]: Resizing completed. machine # [ 66.629244] systemd-homework[1291]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 66.630792] systemd-homework[1291]: Read embedded .identity file. machine # [ 66.650434] systemd-homework[1291]: Provided password unlocks user record. machine # [ 66.651375] systemd-homework[1291]: Reconciling user identities completed (host and header version were identical). machine # [ 66.652699] systemd-homework[1291]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 66.655066] systemd-homework[1291]: Recursive changing of ownership not necessary, skipped. machine # [ 66.656258] systemd-homework[1291]: Synchronized disk. machine # [ 66.658385] systemd-homework[1291]: Moving to final mount point /home/test-homed-user completed. machine # [ 66.680708] systemd-homework[1291]: Activation completed. machine # [ 66.681840] systemd-homework[1291]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 66.692913] systemd-homed[518]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 66.701365] systemd-homed[518]: test-homed-user: changing state activating → active machine # [ 66.710294] systemd[1]: Starting User Manager for UID 60388... machine # [ 66.733713] (systemd)[1334]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 66.770287] (systemd)[1334]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 66.776425] systemd-logind[538]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 66.791972] systemd[1334]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.865230] systemd[1334]: Queued start job for default target Main User Target. machine # [ 66.867840] systemd[1334]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.870278] systemd[1334]: Created slice User Application Slice. machine # [ 66.872056] systemd[1334]: Started Daily Cleanup of User's Temporary Directories. machine # [ 66.873204] systemd[1334]: Reached target Paths. machine # [ 66.873869] systemd[1334]: Reached target Timers. machine # [ 66.876078] systemd[1334]: Starting D-Bus User Message Bus Socket... machine # [ 66.877965] systemd[1334]: Starting Create User Files and Directories... machine # [ 66.903246] systemd[1334]: Finished Create User Files and Directories. machine # [ 66.907076] systemd[1334]: Listening on D-Bus User Message Bus Socket. machine # [ 66.907965] systemd[1334]: Reached target Sockets. machine # [ 66.908671] systemd[1334]: Reached target Basic System. machine # [ 66.910063] systemd[1]: Started User Manager for UID 60388. machine # [ 66.912529] systemd[1334]: Starting Run user-specific NixOS activation... machine # [ 66.943143] systemd[1334]: Finished Run user-specific NixOS activation. machine # [ 66.944379] systemd[1334]: Reached target Main User Target. machine # [ 66.946192] systemd[1334]: Startup finished in 159ms. machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.15 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.05 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' machine # [ 68.903767] sshd-session[1284]: Received disconnect from 2001:db8:1::2 port 50666:11: disconnected by user machine # [ 68.905971] sshd-session[1284]: Disconnected from user test-homed-user 2001:db8:1::2 port 50666 machine # [ 68.907537] sshd-session[1277]: pam_unix(sshd:session): session closed for user test-homed-user machine # [ 68.909232] sshd-session[1277]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 68.913313] systemd[1]: session-3.scope: Deactivated successfully. sshClient: (finished: sending keys 'exit\n', in 0.05 seconds) (finished: subtest: ssh as homed user, in 6.56 seconds) (finished: run the VM test script, in 70.32 seconds) machine # [ 68.917618] systemd-logind[538]: Session 3 logged out. Waiting for processes to exit. machine # [ 68.920157] systemd-logind[538]: Removed session 3. sshClient # [ 68.897627] login[692]: pam_unix(login:session): session closed for user test-normal-user sshClient # [ 68.902238] systemd[1]: getty@tty1.service: Deactivated successfully. sshClient # [ 68.908709] systemd[1]: session-1.scope: Deactivated successfully. sshClient # [ 68.910284] systemd[1]: session-1.scope: Consumed 111ms CPU time over 36.134s wall clock time, 9.5M memory peak, 12K written to disk, 25.8K incoming IP traffic, 24.7K outgoing IP traffic. sshClient # [ 68.913929] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. sshClient # [ 68.916979] systemd-logind[533]: Session 1 logged out. Waiting for processes to exit. sshClient # [ 68.920639] systemd[1]: Started Getty on tty1. sshClient # [ 68.923953] systemd-logind[533]: Removed session 1. test script finished in 70.48s cleanup kill QemuMachine (pid 48) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) machine # [2026-10-18T02:50:44Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-18T02:50:44Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-18T02:50:44Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 47) sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) sshClient # [2026-10-18T02:50:44Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-10-18T02:50:44Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-10-18T02:50:44Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.33 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