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.02 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script start all VMs machine: starting vm sshClient: starting vm sshClient: QEMU running (pid 47) sshClient # Disk image does not exist, creating the virtualisation disk image... sshClient # Formatting '/build/vm-state-sshClient/tmp.W5RX1G8xy2', fmt=raw size=1073741824 sshClient # mke2fs 1.47.4 (6-Mar-2025) machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 48) machine # Formatting '/build/vm-state-machine/tmp.wvW6PqFICo', fmt=raw size=1073741824 sshClient # Discarding device blocks: 0/262144 done machine # mke2fs 1.47.4 (6-Mar-2025) sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Discarding device blocks: 0/262144 done sshClient # Filesystem UUID: 9c2e73ec-ba5b-471d-b14a-92fd0d405a01 machine # Creating filesystem with 262144 4k blocks and 65536 inodes sshClient # Superblock backups stored on blocks: machine # Filesystem UUID: 0fe2fb69-7f4f-4812-bcb2-e0682d1ceeb6 sshClient # 32768, 98304, 163840, 229376 machine # Superblock backups stored on blocks: sshClient # machine # 32768, 98304, 163840, 229376 sshClient # Allocating group tables: 0/8 done machine # sshClient # Writing inode tables: 0/8 done machine # Allocating group tables: 0/8 done sshClient # Creating journal (8192 blocks): done machine # Writing inode tables: 0/8 done sshClient # Writing superblocks and filesystem accounting information: 0/8 done machine # Creating journal (8192 blocks): done sshClient # machine # Writing superblocks and filesystem accounting information: 0/8 done sshClient # Virtualisation disk image created. machine # sshClient # Starting virtiofs daemons... machine # Virtualisation disk image created. sshClient # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # Starting virtiofs daemons... sshClient # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-12T21:45:32Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-12T21:45:32Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-12T21:45:32Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-12T21:45:32Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-12T21:45:32Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-12T21:45:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-12T21:45:32Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-12T21:45:32Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-12T21:45:32Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-12T21:45:32Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-10-12T21:45:32Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-12T21:45:32Z INFO virtiofsd] Client connected, servicing requests (finished: start all VMs, in 0.35 seconds) machine # [2026-10-12T21:45:32Z INFO virtiofsd] Client connected, servicing requests subtest: create systemd-homed user on first boot prompt machine: waiting for unit systemd-homed.service machine: waiting for the VM to finish booting sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) sshClient # sshClient # sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)... sshClient # sshClient # sshClient # sshClient # sshClient # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 sshClient # Press Ctrl-B to configure iPXE (PCI 00:05.0)... sshClient # sshClient # machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # sshClient # Booting from ROM... machine # Booting from ROM... sshClient # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026 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/108wv115iadpag4v2l3vna4xza4i5jwc-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/f2gva8qp4y8ka2axaxvldi7nx9cnnhjs-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.000000] BIOS-provided physical RAM map: sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 UTC 2026 sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved 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/r5zrkjjilx96xbwkn3m31z3lsraq05cj-nixos-system-machine-test/init regInfo=/nix/.ro-store/2jg125s3zwlvvwkxhi93zakqdfwmgzza-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-provided physical RAM map: sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable sshClient # [ 0.000000] NX (Execute Disable) protection: active sshClient # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved sshClient # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved sshClient # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved sshClient # [ 0.000000] Hypervisor detected: KVM sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved sshClient # [ 0.000000] kvm-clock: using sched offset of 501275553 cycles machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns sshClient # [ 0.000004] tsc: Detected 2400.012 MHz processor machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 sshClient # [ 0.000763] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM sshClient # [ 0.000789] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 sshClient # [ 0.000792] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 sshClient # [ 0.002679] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.000000] kvm-clock: using sched offset of 479669211 cycles sshClient # [ 0.002690] Using GB pages for direct mapping sshClient # [ 0.002808] RAMDISK: [mem 0x3e2b4000-0x3ffcffff] machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns sshClient # [ 0.002815] ACPI: Early table checksum verification disabled machine # [ 0.000005] tsc: Detected 2400.012 MHz processor sshClient # [ 0.002818] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.000763] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 sshClient # [ 0.002822] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000789] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs sshClient # [ 0.002826] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.000792] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002679] found SMP MP-table at [mem 0x000f5450-0x000f545f] sshClient # [ 0.002833] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002691] Using GB pages for direct mapping sshClient # [ 0.002835] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002779] RAMDISK: [mem 0x3e2b1000-0x3ffcffff] machine # [ 0.002787] ACPI: Early table checksum verification disabled sshClient # [ 0.002836] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002789] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) sshClient # [ 0.002838] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002792] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002840] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002797] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002841] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002804] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002843] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002806] ACPI: FACS 0x000000003FFE0000 000040 sshClient # [ 0.002844] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002808] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002844] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002809] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002845] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] sshClient # [ 0.002845] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002811] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002846] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002812] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) sshClient # [ 0.002846] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.002814] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] sshClient # [ 0.003062] No NUMA configuration found machine # [ 0.002815] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] sshClient # [ 0.003063] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.002815] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002816] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] sshClient # [ 0.003065] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.002816] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] sshClient # [ 0.005534] Zone ranges: sshClient # [ 0.005535] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.002817] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] sshClient # [ 0.005536] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.002817] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] sshClient # [ 0.005537] Normal empty machine # [ 0.003036] No NUMA configuration found sshClient # [ 0.005538] Device empty sshClient # [ 0.005539] Movable zone start for each node machine # [ 0.003036] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] sshClient # [ 0.005540] Early memory node ranges machine # [ 0.003039] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] sshClient # [ 0.005540] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005324] Zone ranges: sshClient # [ 0.005541] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005325] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005326] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] sshClient # [ 0.005542] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005328] Normal empty machine # [ 0.005328] Device empty sshClient # [ 0.005561] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005329] Movable zone start for each node sshClient # [ 0.005822] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.005330] Early memory node ranges sshClient # [ 0.023061] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.005330] node 0: [mem 0x0000000000001000-0x000000000009efff] sshClient # [ 0.023500] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.005331] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] sshClient # [ 0.023509] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.005332] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] sshClient # [ 0.023533] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.005352] On node 0, zone DMA: 1 pages in unavailable ranges sshClient # [ 0.023536] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.005619] On node 0, zone DMA: 97 pages in unavailable ranges sshClient # [ 0.023537] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.022945] On node 0, zone DMA32: 40 pages in unavailable ranges sshClient # [ 0.023539] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.023389] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.023400] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) sshClient # [ 0.023540] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.023426] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 sshClient # [ 0.023540] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.023429] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) sshClient # [ 0.023543] ACPI: Using ACPI (MADT) for SMP configuration information sshClient # [ 0.023544] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.023430] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) sshClient # [ 0.023547] TSC deadline timer available machine # [ 0.023432] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) sshClient # [ 0.023551] CPU topo: Max. logical packages: 1 sshClient # [ 0.023552] CPU topo: Max. logical dies: 1 machine # [ 0.023433] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) sshClient # [ 0.023552] CPU topo: Max. dies per package: 1 machine # [ 0.023434] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) sshClient # [ 0.023556] CPU topo: Max. threads per core: 1 machine # [ 0.023436] ACPI: Using ACPI (MADT) for SMP configuration information sshClient # [ 0.023556] CPU topo: Num. cores per package: 1 sshClient # [ 0.023557] CPU topo: Num. threads per package: 1 machine # [ 0.023437] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.023440] TSC deadline timer available sshClient # [ 0.023557] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.023444] CPU topo: Max. logical packages: 1 sshClient # [ 0.023572] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.023445] CPU topo: Max. logical dies: 1 machine # [ 0.023445] CPU topo: Max. dies per package: 1 sshClient # [ 0.023598] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.023449] CPU topo: Max. threads per core: 1 machine # [ 0.023449] CPU topo: Num. cores per package: 1 sshClient # [ 0.023600] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.023450] CPU topo: Num. threads per package: 1 sshClient # [ 0.023601] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.023450] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs sshClient # [ 0.023603] Booting paravirtualized kernel on KVM machine # [ 0.023467] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() sshClient # [ 0.023605] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.023495] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] sshClient # [ 0.028245] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.023497] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] sshClient # [ 0.030367] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.023498] [mem 0x40000000-0xafffffff] available for PCI devices sshClient # [ 0.030406] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.023508] Booting paravirtualized kernel on KVM machine # [ 0.023510] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.028132] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.030265] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 sshClient # [ 0.030408] 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/108wv115iadpag4v2l3vna4xza4i5jwc-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/f2gva8qp4y8ka2axaxvldi7nx9cnnhjs-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.030307] kvm-guest: PV spinlocks disabled, single CPU sshClient # [ 0.030497] Unknown kernel command line parameters "regInfo=/nix/.ro-store/f2gva8qp4y8ka2axaxvldi7nx9cnnhjs-closure-info/registration", will be passed to user space. sshClient # [ 0.030509] random: crng init done sshClient # [ 0.030510] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.030309] 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/r5zrkjjilx96xbwkn3m31z3lsraq05cj-nixos-system-machine-test/init regInfo=/nix/.ro-store/2jg125s3zwlvvwkxhi93zakqdfwmgzza-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.030530] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) sshClient # [ 0.031061] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) sshClient # [ 0.031089] Fallback order for Node 0: 0 machine # [ 0.030398] Unknown kernel command line parameters "regInfo=/nix/.ro-store/2jg125s3zwlvvwkxhi93zakqdfwmgzza-closure-info/registration", will be passed to user space. machine # [ 0.030411] random: crng init done sshClient # [ 0.031091] Built 1 zonelists, mobility grouping on. Total pages: 262006 sshClient # [ 0.031092] Policy zone: DMA32 machine # [ 0.030411] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes sshClient # [ 0.033184] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.030432] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) sshClient # [ 0.035537] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 sshClient # [ 0.037756] allocated 2097152 bytes of page_ext machine # [ 0.030970] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) sshClient # [ 0.047646] ftrace: allocating 48837 entries in 192 pages machine # [ 0.030998] Fallback order for Node 0: 0 sshClient # [ 0.047648] ftrace: allocated 192 pages with 2 groups machine # [ 0.031001] Built 1 zonelists, mobility grouping on. Total pages: 262006 sshClient # [ 0.048464] Dynamic Preempt: lazy machine # [ 0.031002] Policy zone: DMA32 sshClient # [ 0.048595] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.033554] mem auto-init: stack:all(zero), heap alloc:on, heap free:off sshClient # [ 0.048596] rcu: RCU event tracing is enabled. machine # [ 0.035947] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 sshClient # [ 0.048596] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.038171] allocated 2097152 bytes of page_ext sshClient # [ 0.048597] Trampoline variant of Tasks RCU enabled. machine # [ 0.048086] ftrace: allocating 48837 entries in 192 pages sshClient # [ 0.048598] Rude variant of Tasks RCU enabled. machine # [ 0.048088] ftrace: allocated 192 pages with 2 groups sshClient # [ 0.048598] Tracing variant of Tasks RCU enabled. machine # [ 0.048914] Dynamic Preempt: lazy machine # [ 0.049083] rcu: Preemptible hierarchical RCU implementation. sshClient # [ 0.048599] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.049083] rcu: RCU event tracing is enabled. sshClient # [ 0.048599] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.049084] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. sshClient # [ 0.048655] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049085] Trampoline variant of Tasks RCU enabled. machine # [ 0.049086] Rude variant of Tasks RCU enabled. sshClient # [ 0.048657] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049086] Tracing variant of Tasks RCU enabled. machine # [ 0.049087] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. sshClient # [ 0.048658] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049087] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 sshClient # [ 0.052901] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 sshClient # [ 0.053164] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.049096] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.053170] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.049097] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.053262] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.049098] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.056766] Console: colour VGA+ 80x25 machine # [ 0.053373] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 sshClient # [ 0.056768] printk: legacy console [tty0] enabled machine # [ 0.053645] rcu: srcu_init: Setting srcu_struct sizes based on contention. sshClient # [ 0.086281] printk: legacy console [ttyS0] enabled sshClient # [ 0.189622] ACPI: Core revision 20250807 machine # [ 0.053651] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.053745] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) sshClient # [ 0.190540] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.057296] Console: colour VGA+ 80x25 machine # [ 0.057298] printk: legacy console [tty0] enabled sshClient # [ 0.192091] APIC: Switch to symmetric I/O mode setup machine # [ 0.086712] printk: legacy console [ttyS0] enabled sshClient # [ 0.193113] x2apic enabled machine # [ 0.188478] ACPI: Core revision 20250807 sshClient # [ 0.193877] APIC: Switched APIC routing to: physical x2apic machine # [ 0.189373] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.195756] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.191014] APIC: Switch to symmetric I/O mode setup machine # [ 0.192022] x2apic enabled sshClient # [ 0.196790] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.192811] APIC: Switched APIC routing to: physical x2apic sshClient # [ 0.198512] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.194709] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 sshClient # [ 0.199593] x86/cpu: User Mode Instruction Prevention (UMIP) activated sshClient # [ 0.201599] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.195738] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns sshClient # [ 0.202509] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.197422] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) sshClient # [ 0.203513] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.198503] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.200463] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 sshClient # [ 0.204510] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.201379] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 sshClient # [ 0.206509] Transient Scheduler Attacks: Vulnerable: No microcode sshClient # [ 0.207509] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.202422] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto sshClient # [ 0.208509] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.203419] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.205419] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.206418] Spectre V2 : Mitigation: Enhanced / Automatic IBRS sshClient # [ 0.209509] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.207418] Speculative Return Stack Overflow: Mitigation: Safe RET sshClient # [ 0.211516] Spectre V2 : Enabling IBPB for BPF sshClient # [ 0.212255] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier sshClient # [ 0.213509] active return thunk: srso_alias_return_thunk machine # [ 0.208418] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization sshClient # [ 0.214529] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.210425] Spectre V2 : Enabling IBPB for BPF sshClient # [ 0.215509] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.216509] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.211158] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.212419] active return thunk: srso_alias_return_thunk sshClient # [ 0.217509] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' sshClient # [ 0.218509] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.213439] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' sshClient # [ 0.219509] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.214419] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.215418] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' sshClient # [ 0.220509] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.216418] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' sshClient # [ 0.222463] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.217418] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' sshClient # [ 0.223261] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 sshClient # [ 0.224256] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.218418] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' sshClient # [ 0.225238] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.220214] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' sshClient # [ 0.226262] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.221419] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.222418] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 sshClient # [ 0.227265] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.223419] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.224418] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.225418] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.226418] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. sshClient # [ 0.261043] Freeing SMP alternatives memory: 48K sshClient # [ 0.261511] pid_max: default: 32768 minimum: 301 sshClient # [ 0.262593] LSM: initializing lsm=capability,landlock,yama,bpf,ima sshClient # [ 0.263618] landlock: Up and running. sshClient # [ 0.264510] Yama: becoming mindful. sshClient # [ 0.265513] LSM support for eBPF active machine # [ 0.260348] Freeing SMP alternatives memory: 48K machine # [ 0.260982] pid_max: default: 32768 minimum: 301 sshClient # [ 0.266248] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.261521] LSM: initializing lsm=capability,landlock,yama,bpf,ima sshClient # [ 0.267514] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.262520] landlock: Up and running. machine # [ 0.263419] Yama: becoming mindful. machine # [ 0.264628] LSM support for eBPF active sshClient # [ 0.269839] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.265442] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.271080] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.266438] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.271518] ... version: 2 sshClient # [ 0.272280] ... bit width: 48 sshClient # [ 0.272511] ... generic counters: 6 machine # [ 0.268967] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) sshClient # [ 0.273241] ... generic bitmap: 000000000000003f sshClient # [ 0.273511] ... fixed-purpose counters: 0 machine # [ 0.269967] Performance Events: Fam17h+ core perfctr, AMD PMU driver. sshClient # [ 0.274257] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.270424] ... version: 2 sshClient # [ 0.274511] ... value mask: 0000ffffffffffff machine # [ 0.271169] ... bit width: 48 machine # [ 0.271421] ... generic counters: 6 sshClient # [ 0.275438] ... max period: 00007fffffffffff machine # [ 0.272123] ... generic bitmap: 000000000000003f sshClient # [ 0.276223] ... global_ctrl mask: 000000000000003f machine # [ 0.272432] ... fixed-purpose counters: 0 sshClient # [ 0.276615] signal: max sigframe size: 3376 machine # [ 0.273178] ... fixed-purpose bitmap: 0000000000000000 sshClient # [ 0.277446] rcu: Hierarchical SRCU implementation. machine # [ 0.273421] ... value mask: 0000ffffffffffff sshClient # [ 0.278111] rcu: Max phase no-delay instances is 400. machine # [ 0.274340] ... max period: 00007fffffffffff machine # [ 0.275167] ... global_ctrl mask: 000000000000003f machine # [ 0.275528] signal: max sigframe size: 3376 machine # [ 0.276404] rcu: Hierarchical SRCU implementation. machine # [ 0.277059] rcu: Max phase no-delay instances is 400. sshClient # [ 0.283038] smp: Bringing up secondary CPUs ... sshClient # [ 0.283525] smp: Brought up 1 node, 1 CPU sshClient # [ 0.284205] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) sshClient # [ 0.284699] Memory: 940328K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 100328K reserved, 0K cma-reserved) machine # [ 0.281976] smp: Bringing up secondary CPUs ... sshClient # [ 0.285725] devtmpfs: initialized machine # [ 0.282445] smp: Brought up 1 node, 1 CPU sshClient # [ 0.286610] x86/mm: Memory block size: 128MB machine # [ 0.283152] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) sshClient # [ 0.288278] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.283650] Memory: 940292K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 100340K reserved, 0K cma-reserved) machine # [ 0.284640] devtmpfs: initialized sshClient # [ 0.289443] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.285448] x86/mm: Memory block size: 128MB sshClient # [ 0.290596] pinctrl core: initialized pinctrl subsystem sshClient # [ 0.291751] PM: RTC time: 21:45:32, date: 2026-10-12 machine # [ 0.287095] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.287446] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.288515] pinctrl core: initialized pinctrl subsystem sshClient # [ 0.295261] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.289717] PM: RTC time: 21:45:32, date: 2026-10-12 sshClient # [ 0.296687] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations sshClient # [ 0.297527] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations sshClient # [ 0.298663] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.293671] NET: Registered PF_NETLINK/PF_ROUTE protocol family sshClient # [ 0.299520] audit: initializing netlink subsys (disabled) sshClient # [ 0.300635] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.294795] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations sshClient # [ 0.300637] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.295439] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations sshClient # [ 0.301512] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.296583] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations sshClient # [ 0.302486] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.297431] audit: initializing netlink subsys (disabled) sshClient # [ 0.303348] audit: type=2000 audit(1791841533.438:1): state=initialized audit_enabled=0 res=1 machine # [ 0.298551] thermal_sys: Registered thermal governor 'fair_share' sshClient # [ 0.305516] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.298553] thermal_sys: Registered thermal governor 'bang_bang' sshClient # [ 0.305532] cpuidle: using governor menu machine # [ 0.299422] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.300385] thermal_sys: Registered thermal governor 'user_space' sshClient # [ 0.307760] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.301167] audit: type=2000 audit(1791841533.442:1): state=initialized audit_enabled=0 res=1 sshClient # [ 0.308734] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.302424] thermal_sys: Registered thermal governor 'power_allocator' sshClient # [ 0.309514] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.302437] cpuidle: using governor menu sshClient # [ 0.310522] PCI: Using configuration type 1 for base access machine # [ 0.304624] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 sshClient # [ 0.311653] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.305675] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.306423] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.307433] PCI: Using configuration type 1 for base access machine # [ 0.308539] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. sshClient # [ 0.316746] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages sshClient # [ 0.317512] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page sshClient # [ 0.322513] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.315665] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages sshClient # [ 0.323511] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.316423] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.321422] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.322429] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page sshClient # [ 0.333954] ACPI: Added _OSI(Module Device) sshClient # [ 0.334513] ACPI: Added _OSI(Processor Device) sshClient # [ 0.335283] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.331067] ACPI: Added _OSI(Module Device) machine # [ 0.331423] ACPI: Added _OSI(Processor Device) machine # [ 0.332171] ACPI: Added _OSI(Processor Aggregator Device) sshClient # [ 0.345083] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.338967] ACPI: 1 ACPI AML tables successfully acquired and loaded sshClient # [ 0.348943] ACPI: Interpreter enabled sshClient # [ 0.349527] ACPI: PM: (supports S0 S3 S4 S5) sshClient # [ 0.350249] ACPI: Using IOAPIC for interrupt routing machine # [ 0.342318] ACPI: Interpreter enabled machine # [ 0.342897] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.343422] ACPI: Using IOAPIC for interrupt routing machine # [ 0.344305] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug sshClient # [ 0.352566] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug sshClient # [ 0.353513] PCI: Using E820 reservations for host bridge windows sshClient # [ 0.356651] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.349423] PCI: Using E820 reservations for host bridge windows machine # [ 0.350564] ACPI: Enabled 2 GPEs in block 00 to 3F sshClient # [ 0.362206] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) sshClient # [ 0.362518] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] sshClient # [ 0.363595] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] sshClient # [ 0.364633] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.358455] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) sshClient # [ 0.365856] PCI host bridge to bus 0000:00 machine # [ 0.359426] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] sshClient # [ 0.366515] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.360512] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] sshClient # [ 0.367511] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.361546] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] sshClient # [ 0.368512] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.362773] PCI host bridge to bus 0000:00 sshClient # [ 0.369512] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.363426] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] sshClient # [ 0.370511] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.364421] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] sshClient # [ 0.371511] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.365421] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] sshClient # [ 0.372512] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.366421] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] sshClient # [ 0.373524] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.367421] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.374961] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.368421] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.369421] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.370453] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.371866] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint sshClient # [ 0.377630] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] sshClient # [ 0.378524] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] sshClient # [ 0.379578] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] sshClient # [ 0.380819] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.374496] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.375433] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] sshClient # [ 0.382216] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.376511] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.377595] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] sshClient # [ 0.385577] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] sshClient # [ 0.386442] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.379346] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.387293] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] sshClient # [ 0.388349] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.382441] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] sshClient # [ 0.389867] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.383288] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.384189] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.384427] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] sshClient # [ 0.391519] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] sshClient # [ 0.392373] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] sshClient # [ 0.393277] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.386389] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.394939] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.389400] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.390083] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.390442] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] sshClient # [ 0.397562] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.391962] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint sshClient # [ 0.398518] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] sshClient # [ 0.399501] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] sshClient # [ 0.400979] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.394707] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] sshClient # [ 0.402519] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.396058] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] sshClient # [ 0.403369] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.396443] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] sshClient # [ 0.404273] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.397995] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.404518] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.400190] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] sshClient # [ 0.406074] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.400428] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.401431] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] sshClient # [ 0.407524] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] sshClient # [ 0.408522] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.402428] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] sshClient # [ 0.410067] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.403959] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint sshClient # [ 0.411524] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.405446] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.406432] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] sshClient # [ 0.412503] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.407973] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.414136] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.415524] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.409444] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] sshClient # [ 0.416511] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.410398] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] sshClient # [ 0.418047] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.412014] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.419524] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.413464] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] sshClient # [ 0.420533] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.414443] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] sshClient # [ 0.422054] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.415954] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.423527] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.417434] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] sshClient # [ 0.424391] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.418444] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] sshClient # [ 0.425295] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.419996] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint sshClient # [ 0.426965] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.422310] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] sshClient # [ 0.429548] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.423084] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] sshClient # [ 0.430434] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.423443] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] sshClient # [ 0.431349] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.424981] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.433158] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.434200] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.427204] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] sshClient # [ 0.434710] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.427429] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.428382] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] sshClient # [ 0.436494] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.429848] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.437421] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.431179] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] sshClient # [ 0.439162] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.431617] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.433443] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.434471] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.435980] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] sshClient # [ 0.439723] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint sshClient # [ 0.442148] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] sshClient # [ 0.442782] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.436642] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint sshClient # [ 0.443792] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.438892] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] sshClient # [ 0.444761] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.439695] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint sshClient # [ 0.446570] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.440703] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO sshClient # [ 0.447467] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.441664] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint sshClient # [ 0.448573] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.443331] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] sshClient # [ 0.450171] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.444036] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.444766] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.446157] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] sshClient # [ 0.454109] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 sshClient # [ 0.454620] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 sshClient # [ 0.455614] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.449632] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 sshClient # [ 0.456610] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.450534] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 sshClient # [ 0.457617] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 sshClient # [ 0.458610] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.451524] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.452527] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 sshClient # [ 0.459620] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.453517] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 sshClient # [ 0.460613] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.454519] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 sshClient # [ 0.461550] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.455520] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 sshClient # [ 0.462527] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.456516] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 sshClient # [ 0.463529] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 sshClient # [ 0.464474] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.457454] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 sshClient # [ 0.465266] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.458433] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.465525] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.459429] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.460436] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.461435] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 sshClient # [ 0.466486] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.462433] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 sshClient # [ 0.467529] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.463433] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.464414] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.469553] iommu: Default domain type: Translated sshClient # [ 0.470408] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.466463] iommu: Default domain type: Translated sshClient # [ 0.471576] ACPI: bus type USB registered machine # [ 0.467267] iommu: DMA domain TLB invalidation policy: lazy mode sshClient # [ 0.472355] usbcore: registered new interface driver usbfs machine # [ 0.468412] ACPI: bus type USB registered sshClient # [ 0.473265] usbcore: registered new interface driver hub machine # [ 0.469144] usbcore: registered new interface driver usbfs sshClient # [ 0.473523] usbcore: registered new device driver usb machine # [ 0.469437] usbcore: registered new interface driver hub machine # [ 0.470324] usbcore: registered new device driver usb sshClient # [ 0.475317] NetLabel: Initializing sshClient # [ 0.475518] NetLabel: domain hash size = 128 machine # [ 0.471956] NetLabel: Initializing sshClient # [ 0.476267] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.472422] NetLabel: domain hash size = 128 sshClient # [ 0.476542] NetLabel: unlabeled traffic allowed by default machine # [ 0.473119] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO sshClient # [ 0.477470] PCI: Using ACPI for IRQ routing machine # [ 0.473466] NetLabel: unlabeled traffic allowed by default machine # [ 0.474393] PCI: Using ACPI for IRQ routing sshClient # [ 0.520779] pci 0000:00:01.0: vgaarb: setting as boot VGA device sshClient # [ 0.521508] pci 0000:00:01.0: vgaarb: bridge control possible sshClient # [ 0.521508] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none sshClient # [ 0.521516] vgaarb: loaded machine # [ 0.518829] pci 0000:00:01.0: vgaarb: setting as boot VGA device sshClient # [ 0.522272] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.519417] pci 0000:00:01.0: vgaarb: bridge control possible sshClient # [ 0.522513] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.519417] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.519427] vgaarb: loaded machine # [ 0.520235] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.521048] hpet0: 3 comparators, 64-bit 100.000000 MHz counter sshClient # [ 0.525600] clocksource: Switched to clocksource kvm-clock sshClient # [ 0.527331] VFS: Disk quotas dquot_6.6.0 sshClient # [ 0.529835] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) sshClient # [ 0.531223] pnp: PnP ACPI init machine # [ 0.526511] clocksource: Switched to clocksource kvm-clock sshClient # [ 0.532005] ACPI: IRQ 4 override to edge(!), high(!) sshClient # [ 0.532991] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved sshClient # [ 0.534544] pnp: PnP ACPI: found 5 devices machine # [ 0.529982] VFS: Disk quotas dquot_6.6.0 machine # [ 0.530737] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.532154] pnp: PnP ACPI init machine # [ 0.532973] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.533957] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.535554] pnp: PnP ACPI: found 5 devices sshClient # [ 0.542127] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns sshClient # [ 0.543595] clocksource: Switched to clocksource acpi_pm sshClient # [ 0.544602] NET: Registered PF_INET protocol family sshClient # [ 0.545678] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.543557] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.545055] clocksource: Switched to clocksource acpi_pm machine # [ 0.546060] NET: Registered PF_INET protocol family machine # [ 0.547141] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) sshClient # [ 0.562700] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.564250] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.565619] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.566968] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) sshClient # [ 0.568259] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.564103] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.569438] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.565621] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.570744] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.566952] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.571867] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.573039] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.568271] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) sshClient # [ 0.573986] NET: Registered PF_XDP protocol family machine # [ 0.569502] TCP: Hash tables configured (established 8192 bind 8192) sshClient # [ 0.574865] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.570618] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) sshClient # [ 0.575890] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.571930] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.576906] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.573058] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.578001] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.574275] NET: Registered PF_UNIX/PF_LOCAL protocol family sshClient # [ 0.579138] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.575229] NET: Registered PF_XDP protocol family sshClient # [ 0.580259] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.576086] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] sshClient # [ 0.582047] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.577116] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.578128] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] sshClient # [ 0.584238] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.579363] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.580494] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.581631] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.586724] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.583439] ACPI: \_SB_.GSIA: Enabled at IRQ 16 sshClient # [ 0.588831] ACPI: \_SB_.GSID: Enabled at IRQ 19 sshClient # [ 0.590614] PCI: CLS 0 bytes, default 64 machine # [ 0.586154] ACPI: \_SB_.GSIB: Enabled at IRQ 17 sshClient # [ 0.591589] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.588099] ACPI: \_SB_.GSIC: Enabled at IRQ 18 sshClient # [ 0.593454] Trying to unpack rootfs image as initramfs... machine # [ 0.590024] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.591663] PCI: CLS 0 bytes, default 64 machine # [ 0.592594] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.594403] Trying to unpack rootfs image as initramfs... sshClient # [ 0.637760] Initialise system trusted keyrings sshClient # [ 0.640521] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.637446] Initialise system trusted keyrings machine # [ 0.640862] workingset: timestamp_bits=40 max_order=18 bucket_order=0 sshClient # [ 0.660961] Key type asymmetric registered sshClient # [ 0.664375] Asymmetric key parser 'x509' registered machine # [ 0.660746] Key type asymmetric registered sshClient # [ 0.665273] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.661487] Asymmetric key parser 'x509' registered sshClient # [ 0.668489] io scheduler mq-deadline registered machine # [ 0.664832] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) sshClient # [ 0.671405] io scheduler kyber registered machine # [ 0.667844] io scheduler mq-deadline registered sshClient # [ 0.672767] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.668638] io scheduler kyber registered sshClient # [ 0.674047] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.671372] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.672746] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A sshClient # [ 0.678132] Linux agpgart interface v0.103 sshClient # [ 0.678882] ACPI: bus type drm_connector registered sshClient # [ 0.681809] usbcore: registered new interface driver usbserial_generic sshClient # [ 0.682948] usbserial: USB Serial support registered for generic machine # [ 0.678614] Linux agpgart interface v0.103 machine # [ 0.679383] ACPI: bus type drm_connector registered sshClient # [ 0.686371] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.682373] usbcore: registered new interface driver usbserial_generic sshClient # [ 0.686371] Please enable it if your BIOS has the CPPC option. machine # [ 0.683483] usbserial: USB Serial support registered for generic sshClient # [ 0.688631] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled sshClient # [ 0.691503] drop_monitor: Initializing network drop monitor service machine # [ 0.686799] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. sshClient # [ 0.692676] NET: Registered PF_INET6 protocol family machine # [ 0.686799] Please enable it if your BIOS has the CPPC option. machine # [ 0.689045] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled sshClient # [ 0.697806] Segment Routing with IPv6 machine # [ 0.692958] drop_monitor: Initializing network drop monitor service sshClient # [ 0.698493] In-situ OAM (IOAM) with IPv6 machine # [ 0.694152] NET: Registered PF_INET6 protocol family sshClient # [ 0.701627] IPI shorthand broadcast: enabled machine # [ 0.697222] Segment Routing with IPv6 machine # [ 0.699808] In-situ OAM (IOAM) with IPv6 machine # [ 0.700871] IPI shorthand broadcast: enabled sshClient # [ 0.709643] sched_clock: Marking stable (569014249, 140338304)->(782433348, -73080795) sshClient # [ 0.711302] registered taskstats version 1 sshClient # [ 0.712280] Loading compiled-in X.509 certificates machine # [ 0.708977] sched_clock: Marking stable (570014290, 138767661)->(781397603, -72615652) machine # [ 0.713876] registered taskstats version 1 machine # [ 0.714860] Loading compiled-in X.509 certificates sshClient # [ 0.730166] Demotion targets for Node 0: null sshClient # [ 0.733405] Key type .fscrypt registered sshClient # [ 0.734139] Key type fscrypt-provisioning registered sshClient # [ 0.735116] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.737364] ima: Allocated hash algorithm: sha1 sshClient # [ 0.738177] ima: No architecture policies found machine # [ 0.733793] Demotion targets for Node 0: null machine # [ 0.734837] Key type .fscrypt registered machine # [ 0.735523] Key type fscrypt-provisioning registered machine # [ 0.736493] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.742367] PM: Magic number: 14:391:803 sshClient # [ 0.744004] RAS: Correctable Errors collector initialized. machine # [ 0.739795] ima: Allocated hash algorithm: sha1 machine # [ 0.740614] ima: No architecture policies found machine # [ 0.744801] PM: Magic number: 14:391:803 machine # [ 0.746487] RAS: Correctable Errors collector initialized. sshClient # [ 0.753063] clk: Disabling unused clocks sshClient # [ 0.755367] PM: genpd: Disabling unused power domains machine # [ 0.755503] clk: Disabling unused clocks machine # [ 0.757808] PM: genpd: Disabling unused power domains sshClient # [ 0.926726] Freeing initrd memory: 29808K sshClient # [ 0.929896] Freeing unused decrypted memory: 2028K sshClient # [ 0.932554] Freeing unused kernel image (initmem) memory: 3656K sshClient # [ 0.933646] Write protecting the kernel read-only data: 32768k machine # [ 0.930374] Freeing initrd memory: 29820K sshClient # [ 0.934986] Freeing unused kernel image (text/rodata gap) memory: 304K sshClient # [ 0.936570] Freeing unused kernel image (rodata/data gap) memory: 692K machine # [ 0.933816] Freeing unused decrypted memory: 2028K machine # [ 0.936597] Freeing unused kernel image (initmem) memory: 3656K machine # [ 0.937679] Write protecting the kernel read-only data: 32768k machine # [ 0.939038] Freeing unused kernel image (text/rodata gap) memory: 304K machine # [ 0.940552] Freeing unused kernel image (rodata/data gap) memory: 692K sshClient # [ 0.987352] x86/mm: Checked W+X mappings: passed, no W+X pages found. sshClient # [ 0.988454] Run /init as init process machine # [ 0.991040] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.992130] Run /init as init process sshClient # [ 0.999660] systemd[1]: Inserted module 'autofs4' machine # [ 1.002756] systemd[1]: Inserted module 'autofs4' sshClient # [ 1.019300] fuse: init (API version 7.45) sshClient # [ 1.026637] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.022426] fuse: init (API version 7.45) sshClient # [ 1.028968] ACPI: \_SB_.GSIH: Enabled at IRQ 23 sshClient # [ 1.032212] ACPI: \_SB_.GSIE: Enabled at IRQ 20 sshClient # [ 1.034265] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.029905] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.032459] ACPI: \_SB_.GSIH: Enabled at IRQ 23 sshClient # [ 1.039596] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.035972] ACPI: \_SB_.GSIE: Enabled at IRQ 20 sshClient # [ 1.041180] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.038222] ACPI: \_SB_.GSIF: Enabled at IRQ 21 sshClient # [ 1.047671] virtiofs virtio6: discovered new tag: shared machine # [ 1.043817] virtiofs virtio5: discovered new tag: nix-store sshClient # [ 1.049232] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.045328] virtiofs virtio5: virtio_fs_setup_dax: No cache capability sshClient # [ 1.052767] virtiofs virtio7: discovered new tag: xchg sshClient # [ 1.054258] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.052813] virtiofs virtio6: discovered new tag: shared machine # [ 1.054317] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.058474] virtiofs virtio7: discovered new tag: xchg machine # [ 1.060125] virtiofs virtio7: virtio_fs_setup_dax: No cache capability sshClient # [ 1.076044] systemd[1]: Successfully made /usr/ read-only. sshClient # [ 1.078011] systemd[1]: systemd 263-37fcd01 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.083469] systemd[1]: Detected virtualization kvm. sshClient # [ 1.084374] systemd[1]: Detected architecture x86-64. sshClient # [ 1.085256] systemd[1]: Running in initrd. sshClient # [ 1.086259] systemd[1]: Initializing machine ID from random generator. machine # [ 1.082555] systemd[1]: Successfully made /usr/ read-only. sshClient # [ 1.087510] systemd[1]: Hostname set to . machine # [ 1.084354] systemd[1]: systemd 263-37fcd01 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.089814] systemd[1]: Detected virtualization kvm. machine # [ 1.090678] systemd[1]: Detected architecture x86-64. machine # [ 1.091613] systemd[1]: Running in initrd. machine # [ 1.092598] systemd[1]: Initializing machine ID from random generator. machine # [ 1.093848] systemd[1]: Hostname set to . sshClient # [ 1.159389] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.164812] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 1.205028] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.200335] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.204009] systemd[1]: Created slice Slice /system/modprobe. sshClient # [ 1.209571] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.205229] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 1.210816] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.206649] systemd[1]: Expecting device /dev/disk/by-label/nixos... sshClient # [ 1.212213] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.207797] systemd[1]: Reached target Path Units. sshClient # [ 1.213315] systemd[1]: Reached target Path Units. machine # [ 1.208681] systemd[1]: Reached target Slice Units. machine # [ 1.209601] systemd[1]: Reached target Swaps. sshClient # [ 1.214264] systemd[1]: Reached target Slice Units. sshClient # [ 1.215146] systemd[1]: Reached target Swaps. machine # [ 1.210401] systemd[1]: Reached target Timer Units. sshClient # [ 1.215922] systemd[1]: Reached target Timer Units. machine # [ 1.211370] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 1.216888] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.212654] systemd[1]: Listening on Journal Socket (/dev/log). sshClient # [ 1.218069] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.213859] systemd[1]: Listening on Journal Sockets. sshClient # [ 1.219244] systemd[1]: Listening on Journal Sockets. machine # [ 1.214848] systemd[1]: Listening on udev Kernel Socket. sshClient # [ 1.220224] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.215814] systemd[1]: Reached target Socket Units. sshClient # [ 1.221173] systemd[1]: Reached target Socket Units. machine # [ 1.217570] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 1.222916] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.221855] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 1.227422] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 1.235419] systemd[1]: Starting Journal Service... machine # [ 1.231351] systemd[1]: Starting Journal Service... sshClient # [ 1.245465] systemd[1]: Starting Load Kernel Modules... machine # [ 1.240865] systemd[1]: Starting Load Kernel Modules... machine # [ 1.256930] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 1.261623] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.262446] systemd[1]: Starting Coldplug All udev Devices... sshClient # [ 1.267540] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.275160] systemd[1]: Finished Create List of Static Device Nodes. sshClient # [ 1.281790] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.279428] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 1.285052] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.288302] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 1.293416] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.293258] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.295871] systemd-journald[65]: Collecting audit messages is disabled. sshClient # [ 1.299841] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config sshClient # [ 1.306173] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.306553] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 1.313424] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 1.318890] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.315431] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. sshClient # [ 1.327439] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.324991] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.351386] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. sshClient # [ 1.360979] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.359998] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 1.369471] systemd[1]: Finished Load Kernel Modules. machine # [ 1.371329] systemd[1]: Finished Load Kernel Modules. sshClient # [ 1.376627] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.380863] systemd[1]: Starting Apply Kernel Variables... sshClient # [ 1.388428] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.400360] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.406986] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.411873] systemd[1]: Reached target Local File Systems. machine # [ 1.274465] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.278383] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.279407] systemd-modules-load[66]: Inserted module 'virtio_gpu' sshClient # [ 1.422886] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.421979] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 1.284501] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.427672] systemd[1]: Started Journal Service. sshClient # sshClient # [ 1.288297] systemd-modules-load[66]: Inserted module 'virtio_balloon' sshClient # [ 1.289391] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.428066] systemd[1]: Started Journal Service. sshClient # [ 1.293071] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.295843] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 1.300067] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 1.301973] systemd[1]: Reached target Local File Systems. sshClient # [ 1.304872] systemd[1]: Starting Create System Files and Directories... machine # [ 1.304789] systemd[1]: Starting Create System Files and Directories... sshClient # [ 1.312072] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.332714] systemd[1]: Finished Create System Files and Directories. sshClient # [ 1.336886] systemd[1]: Finished Create System Files and Directories. machine # [ 1.342980] systemd-udevd[73]: Using default interface naming scheme 'v261'. sshClient # [ 1.360285] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.366149] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 1.382615] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.417770] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.420715] systemd[1]: Reached target System Initialization. machine # [ 1.421601] systemd[1]: Reached target Basic System. sshClient # [ 1.428146] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 1.429656] systemd[1]: Reached target System Initialization. sshClient # [ 1.431055] systemd[1]: Reached target Basic System. machine # [ 1.694517] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.708905] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.709583] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.713266] virtio_blk virtio2: 1/0/0 default/read/poll queues sshClient # [ 1.720471] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.723648] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) sshClient # [ 1.734222] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.730257] ehci-pci 0000:00:1d.7: EHCI Host Controller sshClient # [ 1.735025] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.730999] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 sshClient # [ 1.737012] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.732695] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.739806] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.741114] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.742243] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.747084] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.745895] usb usb1: Product: EHCI Host Controller machine # [ 1.746629] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd machine # [ 1.749160] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.751322] hub 1-0:1.0: USB hub found machine # [ 1.752702] hub 1-0:1.0: 6 ports detected sshClient # [ 1.774155] ehci-pci 0000:00:1d.7: EHCI Host Controller sshClient # [ 1.774922] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 sshClient # [ 1.776703] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.774706] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.775536] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 sshClient # [ 1.785377] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 sshClient # [ 1.786251] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 sshClient # [ 1.789363] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.785305] uhci_hcd 0000:00:1d.0: detected 2 ports sshClient # [ 1.791290] usb usb1: Product: EHCI Host Controller sshClient # [ 1.792363] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd sshClient # [ 1.793102] usb usb1: SerialNumber: 0000:00:1d.7 sshClient # [ 1.796507] hub 1-0:1.0: USB hub found sshClient # [ 1.797097] hub 1-0:1.0: 6 ports detected machine # [ 1.793968] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 sshClient # [ 1.799815] uhci_hcd 0000:00:1d.0: UHCI Host Controller sshClient # [ 1.800533] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.801870] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.803134] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.812815] uhci_hcd 0000:00:1d.0: detected 2 ports sshClient # [ 1.819093] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.677772] systemd[1]: Starting Virtual Console Setup... sshClient # [ 1.828559] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.832824] usb usb2: Product: UHCI Host Controller machine # [ 1.833565] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd sshClient # [ 1.839451] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.700610] systemd[1]: Starting Virtual Console Setup... sshClient # [ 1.706263] (udev-worker)[87]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 1.708422] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.704875] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.706897] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.849813] usb usb2: SerialNumber: 0000:00:1d.0 sshClient # [ 1.856421] usb usb2: Product: UHCI Host Controller sshClient # [ 1.857161] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd sshClient # [ 1.857938] usb usb2: SerialNumber: 0000:00:1d.0 sshClient # [ 1.861166] SCSI subsystem initialized machine # [ 1.719702] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.862019] hub 2-0:1.0: USB hub found machine # [ 1.864726] hub 2-0:1.0: 2 ports detected machine # [ 1.868715] SCSI subsystem initialized machine # [ 1.731689] systemd[1]: Finished Virtual Console Setup. machine # [ 1.738514] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.739963] systemd[1]: Reached target Initrd Root Device. sshClient # [ 1.743869] systemd[1]: Found device /dev/disk/by-label/nixos. sshClient # [ 1.886486] hub 2-0:1.0: USB hub found machine # [ 1.743208] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... sshClient # [ 1.749626] systemd[1]: Reached target Initrd Root Device. sshClient # [ 1.751512] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... sshClient # [ 1.892975] hub 2-0:1.0: 2 ports detected machine # [ 1.888091] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.897335] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.898099] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 sshClient # [ 1.762367] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. sshClient # [ 1.907570] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 sshClient # [ 1.769183] systemd[1]: Finished Virtual Console Setup. machine # [ 1.909033] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.911713] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.914351] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.922523] uhci_hcd 0000:00:1d.1: UHCI Host Controller sshClient # [ 1.923243] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.918511] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.919861] usb usb3: Product: UHCI Host Controller machine # [ 1.920585] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd sshClient # [ 1.927441] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.922867] usb usb3: SerialNumber: 0000:00:1d.1 sshClient # [ 1.928254] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.785304] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.925984] hub 3-0:1.0: USB hub found machine # [ 1.791685] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 1.932542] hub 3-0:1.0: 2 ports detected machine # [ 1.937841] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 1.936405] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.938680] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.942903] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.943731] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 1.947136] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.812325] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.948928] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.953866] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.951856] usb usb4: Product: UHCI Host Controller machine # [ 1.954837] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd sshClient # [ 1.959740] usb usb3: Product: UHCI Host Controller sshClient # [ 1.961152] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.957874] usb usb4: SerialNumber: 0000:00:1d.2 sshClient # [ 1.823340] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. sshClient # [ 1.966478] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 1.962645] hub 4-0:1.0: USB hub found sshClient # [ 1.967855] hub 3-0:1.0: USB hub found machine # [ 1.963551] hub 4-0:1.0: 2 ports detected sshClient # [ 1.969214] hub 3-0:1.0: 2 ports detected sshClient # [ 1.976295] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 1.977062] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 sshClient # [ 1.981845] uhci_hcd 0000:00:1d.2: detected 2 ports sshClient # [ 1.984669] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 sshClient # [ 1.987634] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.988958] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.991398] usb usb4: Product: UHCI Host Controller sshClient # [ 1.992118] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd sshClient # [ 1.994242] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode sshClient # [ 1.995513] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 1.992817] usb 1-1: new high-speed USB device number 2 using ehci-pci sshClient # [ 1.998808] hub 4-0:1.0: USB hub found sshClient # [ 2.001362] hub 4-0:1.0: 2 ports detected sshClient # [ 2.001963] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) sshClient # [ 2.008371] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.012630] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode sshClient # [ 2.019264] scsi host0: ahci machine # [ 2.014078] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.015794] ahci 0000:00:1f.2: flags: 64bit ncq only sshClient # [ 2.021415] scsi host1: ahci sshClient # [ 2.024411] scsi host2: ahci machine # [ 2.020402] scsi host0: ahci machine # [ 2.021646] scsi host1: ahci machine # [ 2.023313] scsi host2: ahci sshClient # [ 2.028400] scsi host3: ahci machine # [ 2.024910] scsi host3: ahci sshClient # [ 2.031599] scsi host4: ahci machine # [ 2.027039] scsi host4: ahci sshClient # [ 2.033115] scsi host5: ahci machine # [ 2.028710] scsi host5: ahci sshClient # [ 2.034100] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 2.030031] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 sshClient # [ 2.035232] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.031424] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 2.036460] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 2.037566] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.032860] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.034225] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.035416] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 sshClient # [ 2.039084] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.036578] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 sshClient # [ 2.042219] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 sshClient # [ 2.043561] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.123886] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.126145] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.128745] usb 1-1: Product: QEMU USB Tablet machine # [ 2.130284] usb 1-1: Manufacturer: QEMU machine # [ 2.131529] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.150953] hid: raw HID events driver (C) Jiri Kosina sshClient # [ 2.166547] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 sshClient # [ 2.169369] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 sshClient # [ 2.172391] usb 1-1: Product: QEMU USB Tablet sshClient # [ 2.174064] usb 1-1: Manufacturer: QEMU sshClient # [ 2.175549] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 sshClient # [ 2.197503] hid: raw HID events driver (C) Jiri Kosina sshClient # [ 2.137860] systemd[1]: Mounting /sysroot... machine # [ 2.137112] systemd[1]: Mounting /sysroot... machine # [ 2.346429] ata1: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.354690] ata4: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.357248] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.354652] ata5: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.360107] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.357206] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) sshClient # [ 2.362686] ata1: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.364956] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.360201] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.362727] ata3.00: applying bridge limits sshClient # [ 2.367755] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.365026] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.367065] ata4: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.370709] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.368164] ata6: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.373151] ata3.00: applying bridge limits machine # [ 2.369346] ata3.00: configured for UDMA/100 machine # [ 2.370629] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 sshClient # [ 2.375160] ata3.00: configured for UDMA/100 sshClient # [ 2.377881] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.441132] usbcore: registered new interface driver usbhid machine # [ 2.442062] usbhid: USB HID core driver sshClient # [ 2.454652] usbcore: registered new interface driver usbhid sshClient # [ 2.457931] usbhid: USB HID core driver machine # [ 2.457982] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray sshClient # [ 2.467710] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.474957] cdrom: Uniform CD-ROM driver Revision: 3.20 sshClient # [ 2.483444] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.478135] 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.482494] 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.490700] 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.492959] 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.514835] EXT4-fs (vda): mounted filesystem 0fe2fb69-7f4f-4812-bcb2-e0682d1ceeb6 r/w with ordered data mode. Quota mode: none. machine # [ 2.382831] systemd[1]: Mounted /sysroot. machine # [ 2.385238] systemd[1]: Reached target Initrd Root File System. sshClient # [ 2.528654] EXT4-fs (vda): mounted filesystem 9c2e73ec-ba5b-471d-b14a-92fd0d405a01 r/w with ordered data mode. Quota mode: none. machine # [ 2.387308] systemd[1]: Starting Mountpoints Configured in the Real Root... sshClient # [ 2.394066] systemd[1]: Mounted /sysroot. sshClient # [ 2.398098] systemd[1]: Reached target Initrd Root File System. sshClient # [ 2.400754] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.406722] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.410259] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.412937] systemd[1]: Reloading... sshClient # [ 2.420508] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload. sshClient # [ 2.427081] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)... sshClient # [ 2.428842] systemd[1]: Reloading... machine # [ 2.486320] systemd[1]: Reloading finished in 71 ms. machine # [ 2.494352] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace... machine # [ 2.497154] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace... sshClient # [ 2.502908] systemd[1]: Reloading finished in 76 ms. machine # [ 2.501160] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.502578] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.503643] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. sshClient # [ 2.511846] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace... sshClient # [ 2.515575] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace... sshClient # [ 2.519339] systemd[1]: initrd-parse-etc.service: Deactivated successfully. sshClient # [ 2.520803] systemd[1]: Finished Mountpoints Configured in the Real Root. sshClient # [ 2.521931] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. sshClient # [ 3.139314] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.139239] systemd[1]: Mounting /sysroot/nix/.ro-store... sshClient # [ 3.146161] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.146180] systemd[1]: Mounting /sysroot/nix/.rw-store... sshClient # [ 3.153153] systemd[1]: Mounting /sysroot/run... machine # [ 3.154249] systemd[1]: Mounting /sysroot/run... sshClient # [ 3.163335] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.165192] systemd[1]: Mounting /sysroot/tmp/shared... sshClient # [ 3.174667] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.174632] systemd[1]: Mounting /sysroot/tmp/xchg... sshClient # [ 3.217469] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.215678] systemd[1]: Mounted /sysroot/nix/.ro-store. sshClient # [ 3.220443] systemd[1]: Mounted /sysroot/nix/.rw-store. sshClient # [ 3.221262] systemd[1]: Mounted /sysroot/run. sshClient # [ 3.221905] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.218737] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.220642] systemd[1]: Mounted /sysroot/run. sshClient # [ 3.223931] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.222732] systemd[1]: Mounted /sysroot/tmp/shared. sshClient # [ 3.227112] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.225826] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.229305] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 3.237394] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 3.238863] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.240923] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.240758] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.242324] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.244670] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.266738] systemd[1]: Mounted /sysroot/nix/store. sshClient # [ 3.270753] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.267847] systemd[1]: Reached target Initrd File Systems. sshClient # [ 3.272081] systemd[1]: Reached target Initrd File Systems. machine # [ 3.269519] systemd[1]: Starting Find NixOS closure... sshClient # [ 3.273437] systemd[1]: Starting Find NixOS closure... sshClient # [ 3.276141] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.273148] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... sshClient # [ 3.293368] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.291775] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. sshClient # [ 3.302081] systemd[1]: Finished Find NixOS closure. machine # [ 3.299757] systemd[1]: Finished Find NixOS closure. sshClient # [ 3.303234] systemd[1]: Reached target Initrd Default Target. machine # [ 3.301083] systemd[1]: Reached target Initrd Default Target. sshClient # [ 3.305092] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.303142] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... sshClient # [ 3.318675] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.315985] systemd[1]: Stopped target Initrd Default Target. sshClient # [ 3.319885] systemd[1]: Stopped target Basic System. machine # [ 3.317326] systemd[1]: Stopped target Basic System. sshClient # [ 3.320784] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.318278] systemd[1]: Stopped target Initrd Root Device. sshClient # [ 3.322100] systemd[1]: Stopped target Path Units. machine # [ 3.319275] systemd[1]: Stopped target Path Units. sshClient # [ 3.322792] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. sshClient # [ 3.323838] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.321114] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. sshClient # [ 3.325049] systemd[1]: Stopped target Slice Units. machine # [ 3.322173] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. sshClient # [ 3.326187] systemd[1]: Stopped target Socket Units. machine # [ 3.323205] systemd[1]: Stopped target Slice Units. machine # [ 3.323912] systemd[1]: Stopped target Socket Units. sshClient # [ 3.327113] systemd[1]: Stopped target System Initialization. machine # [ 3.324759] systemd[1]: Stopped target System Initialization. sshClient # [ 3.328119] systemd[1]: Stopped target Swaps. machine # [ 3.325500] systemd[1]: Stopped target Swaps. sshClient # [ 3.329192] systemd[1]: Stopped target Timer Units. machine # [ 3.326159] systemd[1]: Stopped target Timer Units. sshClient # [ 3.329896] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.326992] systemd[1]: dbus.socket: Deactivated successfully. sshClient # [ 3.330933] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.328112] systemd[1]: Closed D-Bus System Message Bus Socket. sshClient # [ 3.332162] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.329198] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. sshClient # [ 3.333174] systemd[1]: Stopped Find NixOS closure. machine # [ 3.330422] systemd[1]: Stopped Find NixOS closure. sshClient # [ 3.334619] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.331934] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 3.335608] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.332832] systemd[1]: systemd-sysctl.service: Deactivated successfully. sshClient # [ 3.337275] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.334259] systemd[1]: Stopped Apply Kernel Variables. sshClient # [ 3.338206] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.335255] systemd[1]: systemd-modules-load.service: Deactivated successfully. sshClient # [ 3.340060] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.337322] systemd[1]: Stopped Load Kernel Modules. sshClient # [ 3.340797] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.338404] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. sshClient # [ 3.341837] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.339647] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. sshClient # [ 3.342990] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. sshClient # [ 3.343952] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.340922] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.342317] systemd[1]: Stopped Create System Files and Directories. sshClient # [ 3.346093] systemd[1]: Stopped target Local File Systems. sshClient # [ 3.346854] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.344141] systemd[1]: Stopped target Local File Systems. sshClient # [ 3.347712] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.345142] systemd[1]: Stopped target Preparation for Local File Systems. sshClient # [ 3.348614] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.347111] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.348172] systemd[1]: Stopped Coldplug All udev Devices. sshClient # [ 3.351552] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.349241] systemd[1]: Stopping Rule-based Manager for Device Events and Files... sshClient # [ 3.352570] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 3.353535] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.350969] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.352471] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 3.361422] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.360655] systemd[1]: initrd-cleanup.service: Deactivated successfully. sshClient # [ 3.363868] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. sshClient # [ 3.368167] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.365849] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. sshClient # [ 3.369300] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.369088] systemd[1]: systemd-udevd.service: Deactivated successfully. sshClient # [ 3.374121] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.372165] systemd[1]: Stopped Rule-based Manager for Device Events and Files. sshClient # [ 3.375543] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.377655] systemd[1]: Starting Cleanup udev Database... sshClient # [ 3.378518] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.375930] systemd[1]: Starting Cleanup udev Database... sshClient # [ 3.379648] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.376816] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.377953] systemd[1]: Stopped Create Static Device Nodes in /dev. sshClient # [ 3.381223] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. sshClient # [ 3.382386] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.379254] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. sshClient # [ 3.383665] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.381246] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. sshClient # [ 3.384595] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.382251] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.383415] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.384323] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.387150] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 3.399222] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. sshClient # [ 3.400854] systemd[1]: Finished Cleanup udev Database. sshClient # [ 3.402151] systemd[1]: Reached target Switch Root. sshClient # [ 3.403656] systemd[1]: Starting NixOS Activation... machine # [ 3.402982] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.405231] systemd[1]: Finished Cleanup udev Database. machine # [ 3.406054] systemd[1]: Reached target Switch Root. machine # [ 3.407695] systemd[1]: Starting NixOS Activation... sshClient # [ 3.475328] initrd-nixos-activation-start[189]: booting system configuration /nix/store/108wv115iadpag4v2l3vna4xza4i5jwc-nixos-system-sshClient-test machine # [ 3.489625] initrd-nixos-activation-start[188]: booting system configuration /nix/store/r5zrkjjilx96xbwkn3m31z3lsraq05cj-nixos-system-machine-test sshClient # [ 3.500845] initrd-nixos-activation-start[189]: running activation script... machine # [ 3.518088] initrd-nixos-activation-start[188]: running activation script... sshClient # [ 3.709849] initrd-nixos-activation-start[212]: setting up /etc... machine # [ 3.709809] initrd-nixos-activation-start[211]: setting up /etc... sshClient # [ 3.816752] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. sshClient # [ 3.819063] systemd[1]: Finished NixOS Activation. sshClient # [ 3.820222] systemd[1]: Starting Switch Root... machine # [ 3.818414] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 3.821131] systemd[1]: Finished NixOS Activation. machine # [ 3.822373] systemd[1]: Starting Switch Root... sshClient # [ 3.833027] systemd[1]: Switching root. machine # [ 3.837245] systemd[1]: Switching root. sshClient # [ 4.102417] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 4.100906] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 4.167008] NET: Registered PF_VSOCK protocol family sshClient # [ 4.190260] NET: Registered PF_VSOCK protocol family machine # [ 4.187802] systemd[1]: systemd 263-37fcd01 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 # [ 4.191730] systemd[1]: Detected virtualization kvm. machine # [ 4.192462] systemd[1]: Detected architecture x86-64. machine # [ 4.193185] systemd[1]: Detected first boot. machine # [ 4.194657] systemd[1]: Initializing machine ID from random generator. sshClient # [ 4.218954] systemd[1]: systemd 263-37fcd01 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 # [ 4.222991] systemd[1]: Detected virtualization kvm. sshClient # [ 4.223709] systemd[1]: Detected architecture x86-64. sshClient # [ 4.224450] systemd[1]: Detected first boot. sshClient # [ 4.226351] systemd[1]: Initializing machine ID from random generator. machine # [ 4.278808] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 4.315849] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.407929] systemd[1]: Applying preset policy. sshClient # [ 4.417753] systemd[1]: Applying preset policy. machine # [ 4.567965] systemd[1]: Populated /etc with preset unit settings. sshClient # [ 4.596983] systemd[1]: Populated /etc with preset unit settings. machine # [ 4.734874] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 4.736168] systemd[1]: Stopped initrd-switch-root.service. machine # [ 4.738209] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 4.740283] systemd[1]: Created slice Slice /system/getty. machine # [ 4.741543] systemd[1]: Created slice User and Session Slice. machine # [ 4.742460] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 4.743625] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 4.744711] systemd[1]: Expecting device /dev/hvc0... machine # [ 4.745434] systemd[1]: Expecting device /dev/ttyS0... machine # [ 4.746185] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 4.746990] systemd[1]: Stopped target initrd-fs.target. machine # [ 4.747704] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 4.748539] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 4.749359] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 4.750230] systemd[1]: Reached target Path Units. machine # [ 4.750914] systemd[1]: Reached target Remote File Systems. machine # [ 4.751691] systemd[1]: Reached target Slice Units. machine # [ 4.752396] systemd[1]: Reached target Swaps. machine # [ 4.753924] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 4.767969] systemd[1]: Listening on Process Core Dump Socket. machine # [ 4.769606] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 4.771263] systemd[1]: Listening on Factory Reset Management. machine # [ 4.772180] systemd[1]: Listening on Hostname Service Socket. machine # [ 4.774640] systemd[1]: Starting Journal Log Access Socket... machine # [ 4.776231] systemd[1]: Listening on Journal Audit Socket. machine # [ 4.779088] systemd[1]: Listening on Console Output Muting Service Socket. sshClient # [ 4.783746] systemd[1]: initrd-switch-root.service: Deactivated successfully. sshClient # [ 4.785065] systemd[1]: Stopped initrd-switch-root.service. machine # [ 4.780189] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 4.781280] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 4.787114] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 4.782570] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki sshClient # [ 4.789416] systemd[1]: Created slice Slice /system/getty. sshClient # [ 4.790776] systemd[1]: Created slice User and Session Slice. machine # [ 4.786134] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 4.787189] systemd[1]: Listening on udev Varlink Socket. sshClient # [ 4.791742] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 4.788115] systemd[1]: Listening on User Database Manager Socket. sshClient # [ 4.792899] systemd[1]: Started Forward Password Requests to Wall Directory Watch. sshClient # [ 4.793970] systemd[1]: Expecting device /dev/hvc0... sshClient # [ 4.794724] systemd[1]: Expecting device /dev/ttyS0... machine # [ 4.790503] systemd[1]: Mounting Huge Pages File System... sshClient # [ 4.795506] systemd[1]: Reached target Local Encrypted Volumes. sshClient # [ 4.796384] systemd[1]: Stopped target initrd-fs.target. sshClient # [ 4.797155] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 4.793061] systemd[1]: Mounting POSIX Message Queue File System... sshClient # [ 4.797949] systemd[1]: Stopped target initrd-switch-root.target. sshClient # [ 4.798791] systemd[1]: Reached target Virtual Machines and Containers. sshClient # [ 4.799716] systemd[1]: Reached target Path Units. sshClient # [ 4.800449] systemd[1]: Reached target Remote File Systems. sshClient # [ 4.801247] systemd[1]: Reached target Slice Units. sshClient # [ 4.801957] systemd[1]: Reached target Swaps. sshClient # [ 4.803718] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 4.800840] systemd[1]: Mounting Kernel Debug File System... sshClient # [ 4.805950] systemd[1]: Listening on Process Core Dump Socket. sshClient # [ 4.807623] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 4.808226] systemd[1]: Mounting Kernel Trace File System... sshClient # [ 4.809292] systemd[1]: Listening on Factory Reset Management. sshClient # [ 4.821870] systemd[1]: Listening on Hostname Service Socket. machine # [ 4.817893] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 4.824600] systemd[1]: Starting Journal Log Access Socket... sshClient # [ 4.825747] systemd[1]: Listening on Journal Audit Socket. sshClient # [ 4.828127] systemd[1]: Listening on Console Output Muting Service Socket. sshClient # [ 4.829251] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. sshClient # [ 4.830400] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.827212] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 4.831682] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki sshClient # [ 4.835409] systemd[1]: Listening on Disk Repartitioning Service Socket. sshClient # [ 4.836456] systemd[1]: Listening on udev Varlink Socket. sshClient # [ 4.837311] systemd[1]: Listening on User Database Manager Socket. sshClient # [ 4.839735] systemd[1]: Mounting Huge Pages File System... machine # [ 4.835831] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm sshClient # [ 4.842053] systemd[1]: Mounting POSIX Message Queue File System... sshClient # [ 4.846540] systemd[1]: Mounting Kernel Debug File System... machine # [ 4.845286] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore sshClient # [ 4.855637] systemd[1]: Mounting Kernel Trace File System... machine # [ 4.851415] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 4.864212] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 4.866094] systemd[1]: Mounting FUSE Control File System... sshClient # [ 4.873362] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 4.876176] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 4.872100] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 4.883076] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 4.881087] systemd[1]: Starting Journal Service... sshClient # [ 4.889598] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 4.891407] systemd[1]: Starting Load Kernel Modules... sshClient # [ 4.910267] systemd[1]: Mounting FUSE Control File System... machine # [ 4.907998] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... sshClient # [ 4.912693] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 4.922102] systemd[1]: Starting Journal Service... machine # [ 4.919880] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 4.926046] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 4.937681] systemd[1]: Starting Load Kernel Modules... machine # [ 4.935119] systemd[1]: Starting Coldplug All udev Devices... machine # [ 4.943930] systemd[1]: Listening on Journal Log Access Socket. sshClient # [ 4.948801] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 4.945231] systemd-journald[282]: Collecting audit messages is enabled. machine # [ 4.950022] systemd[1]: Mounted Huge Pages File System. sshClient # [ 4.956765] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 4.953724] systemd[1]: Mounted POSIX Message Queue File System. sshClient # [ 4.960462] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.957382] systemd[1]: Mounted Kernel Debug File System. sshClient # [ 4.969034] systemd[1]: Starting Coldplug All udev Devices... machine # [ 4.965035] systemd[1]: Started Journal Service. machine # [ 4.830189] systemd[1]: Queued start job for default target Multi-User System. machine # [ 4.831473] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. machine # [ 4.835360] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 4.836883] systemd[1]: systemd-journald.service: Deactivated successfully. sshClient # [ 4.981619] systemd[1]: Listening on Journal Log Access Socket. machine # [ 4.839425] systemd[1]: Mounted Kernel Trace File System. sshClient # [ 4.984118] systemd[1]: Mounted Huge Pages File System. sshClient # [ 4.985735] systemd-journald[283]: Collecting audit messages is enabled. machine # [ 4.845030] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 4.845929] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 4.989550] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 4.848615] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 4.994350] systemd[1]: Mounted Kernel Debug File System. sshClient # [ 5.002581] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.005852] EXT4-fs (vda): re-mounted 0fe2fb69-7f4f-4812-bcb2-e0682d1ceeb6. machine # [ 5.010698] loop: module loaded sshClient # [ 5.015538] systemd[1]: Finished Create List of Static Device Nodes. sshClient # [ 4.876898] systemd[1]: Queued start job for default target Multi-User System. machine # [ 4.874165] systemd-modules-load[283]: Inserted module 'loop' sshClient # [ 5.019837] loop: module loaded machine # [ 4.877097] systemd[1]: Mounted FUSE Control File System. sshClient # [ 4.881600] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. sshClient # [ 5.023767] systemd[1]: Started Journal Service. sshClient # [ 4.884406] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 4.882906] systemd[1]: Mounting Kernel Configuration File System... sshClient # [ 4.886443] systemd[1]: systemd-journald.service: Deactivated successfully. sshClient # [ 4.887868] systemd-modules-load[284]: Inserted module 'loop' machine # [ 4.887954] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 4.891737] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 4.890714] systemd[1]: Finished Load Kernel Modules. sshClient # [ 4.897233] systemd[1]: Finished Load Kernel Module configfs. machine # [ 4.899171] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 4.900140] systemd[1]: Listening on Disk Image Download Service Socket. sshClient # [ 4.907137] systemd[1]: Mounted FUSE Control File System. sshClient # [ 4.909970] systemd[1]: Finished Load Kernel Modules. machine # [ 4.909401] systemd[1]: Starting Firewall... sshClient # [ 5.055353] EXT4-fs (vda): re-mounted 9c2e73ec-ba5b-471d-b14a-92fd0d405a01. machine # [ 4.915071] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 4.916057] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 4.921154] systemd-oomd[285]: No swap; memory pressure usage will be degraded sshClient # [ 4.928065] systemd[1]: Mounting Kernel Configuration File System... sshClient # [ 4.932065] systemd[1]: Starting Firewall... machine # [ 4.933073] systemd[1]: Starting Load/Save OS Random Seed... sshClient # [ 4.938924] systemd[1]: Starting Apply Kernel Variables... machine # [ 4.939145] systemd[1]: Starting Apply Kernel Variables... machine # [ 4.940195] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.945069] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. sshClient # [ 4.950454] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 4.961879] systemd[1]: Finished Remount Root and Kernel File Systems. sshClient # [ 4.968499] systemd[1]: Listening on Disk Image Download Service Socket. sshClient # [ 4.981832] systemd[1]: Starting Flush Journal to Persistent Storage... sshClient # [ 4.982721] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 4.985333] systemd-oomd[286]: No swap; memory pressure usage will be degraded sshClient # [ 4.989062] systemd[1]: Starting Load/Save OS Random Seed... sshClient # [ 4.989869] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.003808] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 5.139673] systemd-journald[282]: Received client request to flush runtime journal. sshClient # [ 5.062148] systemd[1]: Mounted Kernel Configuration File System. sshClient # [ 5.206693] systemd-journald[283]: Received client request to flush runtime journal. machine # [ 5.103472] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 5.107566] systemd[1]: Mounted Kernel Configuration File System. machine # [ 5.108528] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 5.110808] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 5.113174] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.114249] systemd[1]: Finished Flush Journal to Persistent Storage. sshClient # [ 5.180511] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 5.182434] systemd[1]: Finished Load/Save OS Random Seed. sshClient # [ 5.184658] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. sshClient # [ 5.186215] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 5.188614] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 5.216188] systemd[1]: Finished Coldplug All udev Devices. machine # [ 5.218600] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 5.219845] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 5.222619] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 5.235510] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 5.253115] systemd[1]: Finished Create Static Device Nodes in /dev. sshClient # [ 5.255164] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 5.256906] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 5.265496] systemd-udevd[321]: Using default interface naming scheme 'v261'. machine # [ 5.277277] systemd[1]: Starting User Database Manager... sshClient # [ 5.302359] systemd-udevd[321]: Using default interface naming scheme 'v261'. sshClient # [ 5.313191] systemd[1]: Starting User Database Manager... machine # [ 5.316342] systemd[1]: Started User Database Manager. sshClient # [ 5.353680] systemd[1]: Started User Database Manager. machine # [ 5.369086] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 5.404906] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 5.427581] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 5.459864] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.500811] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 5.522707] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. sshClient # [ 5.536436] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 5.556320] (udev-worker)[362]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 5.558746] (udev-worker)[362]: Network interface NamePolicy= disabled on kernel command line. sshClient # [ 5.562085] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. sshClient # [ 5.588456] (udev-worker)[362]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 5.590907] (udev-worker)[362]: Network interface NamePolicy= disabled on kernel command line. machine # [ 5.600728] systemd[1]: Mounting /run/wrappers... machine # [ 5.633578] systemd[1]: Mounted /run/wrappers. machine # [ 5.634393] systemd[1]: Reached target Local File Systems. machine # [ 5.638703] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 5.641110] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 5.641934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 5.649120] systemd[1]: Mounting /run/wrappers... machine # [ 5.647060] systemd[1]: Starting Create System Files and Directories... sshClient # [ 5.690643] systemd[1]: Mounted /run/wrappers. sshClient # [ 5.691575] systemd[1]: Reached target Local File Systems. sshClient # [ 5.695490] systemd[1]: Listening on Boot Loader Control Service Socket. sshClient # [ 5.699128] systemd[1]: Starting Create SUID/SGID Wrappers... sshClient # [ 5.699975] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 5.705242] systemd[1]: Starting Create System Files and Directories... machine # [ 5.718629] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.719795] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.721130] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.723868] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 5.726428] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.729323] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.730866] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.732475] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.743986] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 5.745231] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 5.746271] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore sshClient # [ 5.747705] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 5.748830] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 5.751869] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 5.753911] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.755593] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.769329] systemd[1]: Finished Create System Files and Directories. machine # [ 5.776456] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 5.783969] systemd[1]: Starting Record System Boot/Shutdown in UTMP... sshClient # [ 5.830311] systemd[1]: Finished Create System Files and Directories. sshClient # [ 5.840088] systemd[1]: Starting Rebuild Journal Catalog... sshClient # [ 5.843187] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 5.860058] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 5.878214] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 6.018595] mousedev: PS/2 mouse device common for all mice machine # [ 5.883359] systemd[1]: Starting Update is Completed... sshClient # [ 5.916696] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 5.929978] systemd[1]: Finished Update is Completed. sshClient # [ 5.944661] systemd[1]: Finished Rebuild Journal Catalog. sshClient # [ 5.951327] systemd[1]: Starting Update is Completed... machine # [ 6.097457] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 sshClient # [ 6.102927] mousedev: PS/2 mouse device common for all mice sshClient # [ 5.997569] systemd[1]: Finished Update is Completed. sshClient # [ 6.158112] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 6.157666] ACPI: button: Power Button [PWRF] sshClient # [ 6.178914] ACPI: button: Power Button [PWRF] machine # [ 6.202348] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 6.226959] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 6.256055] rtc_cmos PNP0B00:00: registered as rtc0 sshClient # [ 6.267229] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 6.137174] systemd[1]: Finished Firewall. sshClient # [ 6.145451] systemd[1]: Finished Firewall. sshClient # [ 6.305455] rtc_cmos PNP0B00:00: registered as rtc0 sshClient # [ 6.306206] rtc_cmos PNP0B00:00: setting system clock to 2026-10-12T21:45:38 UTC (1791841538) sshClient # [ 6.307815] systemd-journald[283]: Time jumped backwards, rotating. sshClient # [ 6.311646] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console sshClient # [ 6.322132] parport_pc 00:02: reported by Plug and Play ACPI sshClient # [ 6.325112] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] sshClient # [ 6.337975] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 6.204555] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 6.208547] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 6.209783] systemd[1]: Reached target System Initialization. machine # [ 6.212224] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 6.213765] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 6.214702] systemd[1]: Reached target Timer Units. machine # [ 6.218143] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 6.219404] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine # [ 6.221151] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 6.222853] systemd[1]: Reached target Socket Units. machine # [ 6.223990] systemd[1]: Reached target Basic System. sshClient # [ 6.229607] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 6.227138] systemd[1]: Started backdoor.service. machine # [ 6.228185] systemd[1]: Starting Import lastlog data into lastlog2 database... sshClient # [ 6.232373] systemd[1]: Finished Create SUID/SGID Wrappers. sshClient # [ 6.233833] systemd[1]: Reached target System Initialization. sshClient # [ 6.237688] systemd[1]: Started Discard unused filesystem blocks once a week. sshClient # [ 6.238639] systemd[1]: Started Daily Cleanup of Temporary Directories. sshClient # [ 6.239648] systemd[1]: Reached target Timer Units. sshClient # [ 6.240433] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 6.239078] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 6.242192] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. sshClient # [ 6.243304] systemd[1]: Reached target Socket Units. sshClient # [ 6.244373] systemd[1]: Reached target Basic System. machine # [ 6.248451] systemd[1]: Starting Post-Boot Actions... sshClient # [ 6.251949] systemd[1]: Started backdoor.service. sshClient # [ 6.254056] systemd[1]: Starting Import lastlog data into lastlog2 database... sshClient # [ 6.255958] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.258065] systemd[1]: Started Reset console on configuration changes. sshClient # [ 6.264446] systemd[1]: Starting Post-Boot Actions... machine # [ 6.276434] systemd[1]: Starting resolvconf update... sshClient # [ 6.279546] systemd[1]: Started Reset console on configuration changes. machine # [ 6.283191] systemd[1]: Starting SSH Host Keys Generation... sshClient # [ 6.289966] systemd[1]: Starting resolvconf update... sshClient # [ 6.316197] systemd[1]: Starting Home Area Manager... machine # [ 6.322247] systemd[1]: Starting Home Area Manager... machine # connecting to host... sshClient # [ 6.344670] systemd[1]: Starting D-Bus System Message Bus... machine # [ 6.358279] systemd[1]: Finished Post-Boot Actions. machine # [ 6.370187] nsncd[511]: Oct 12 21:45:38.723 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 6.375840] systemd[1]: Finished Post-Boot Actions. machine # [ 6.376134] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 6.385396] nsncd[505]: Oct 12 21:45:38.718 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 6.389396] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 6.391365] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.390293] systemd[1]: Reached target User and Group Name Lookups. machine # [ 6.403959] systemd[1]: Starting D-Bus System Message Bus... sshClient # connecting to host... sshClient # [ 6.400935] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.422168] systemd[1]: Starting User Login Management... sshClient # [ 6.408148] systemd[1]: Reached target User and Group Name Lookups. machine: connected to guest root shell sshClient # [ 6.423213] systemd[1]: Starting User Login Management... machine: (connecting took 7.11 seconds) machine: (finished: waiting for the VM to finish booting, in 7.12 seconds) machine # [ 6.442671] systemd[1]: Finished Import lastlog data into lastlog2 database. sshClient # [ 6.471669] systemd-homed[510]: Watching /home. machine # [ 6.477302] systemd-homed[519]: Watching /home. machine # [ 6.273210] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 sshClient # [ 6.504711] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 6.279546] rtc_cmos PNP0B00:00: setting system clock to 2026-10-12T21:45:38 UTC (1791841538) machine # [ 6.279643] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs sshClient # [ 6.348864] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized sshClient # [ 6.565830] dbus-broker-launch[511]: Looking up NSS user entry for 'systemd-timesync'... sshClient # [ 6.569691] dbus-broker-launch[511]: NSS returned no entry for 'systemd-timesync' sshClient # [ 6.570832] dbus-broker-launch[511]: Invalid user-name in /nix/store/0xpsamfwb2fb90id94pjcvrvhya11wfz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" sshClient # [ 6.352736] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs sshClient # [ 6.569695] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 6.280035] systemd-journald[282]: Time jumped backwards, rotating. machine # [ 6.286651] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 6.286730] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] sshClient # [ 6.569805] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD sshClient # [ 6.698746] Console: switching to colour dummy device 80x25 sshClient # [ 6.729792] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 6.638958] systemd[1]: Starting Virtual Console Setup... machine # [ 6.643281] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 6.644198] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 6.645064] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 6.645920] systemd[1]: Stopping User and Group Name Lookups... machine # [ 6.648758] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... sshClient # [ 6.730103] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 sshClient # [ 6.813699] [drm] Found bochs VGA, ID 0xb0c5. sshClient # [ 6.813702] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 6.673258] systemd-logind[542]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) sshClient # [ 6.611704] systemd[1]: Started D-Bus System Message Bus. sshClient # [ 6.679538] systemd[1]: Stopped target Host and Network Name Lookups. sshClient # [ 6.680630] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 6.302897] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized sshClient # [ 6.683157] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 6.519418] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 6.519533] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD sshClient # [ 6.686059] systemd[1]: Stopping User and Group Name Lookups... sshClient # [ 6.686987] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... sshClient # [ 6.689122] systemd[1]: nscd.service: Deactivated successfully. sshClient # [ 6.689961] systemd[1]: Stopped Name Service Cache Daemon (nsncd). sshClient # [ 6.691616] dbus-broker-launch[511]: Ready sshClient # [ 6.692989] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 6.695135] systemd[1]: Started Home Area Manager. sshClient # [ 6.695877] systemd[1]: Finished Home Area Activation. sshClient # [ 6.699198] systemd[1]: Starting First Boot Home Area Wizard... sshClient # [ 6.700359] systemd-logind[533]: New seat seat0. sshClient # [ 6.701238] systemd[1]: Starting Virtual Console Setup... sshClient # [ 6.703545] systemd[1]: Started User Login Management. sshClient # [ 6.720699] systemd-logind[533]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) sshClient # [ 6.724640] systemd[1]: Starting linger-users.service... sshClient # [ 6.877781] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic sshClient # [ 6.878597] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 6.628676] Console: switching to colour dummy device 80x25 machine # [ 6.690400] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 6.690683] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 sshClient # [ 6.757742] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 6.758940] nsncd[586]: Oct 12 21:45:39.089 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 6.764241] systemd[1]: Finished resolvconf update. sshClient # [ 6.773372] systemd[1]: Reached target Preparation for Network. sshClient # [ 6.775408] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 6.779127] systemd[1]: Reached target User and Group Name Lookups. sshClient # [ 6.789221] systemd[1]: Starting DHCP Client... sshClient # [ 6.791168] systemd[1]: Starting Address configuration of eth1... sshClient # [ 6.802215] systemd[1]: Starting Extra networking commands.... machine # [ 6.939993] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 6.939996] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. sshClient # [ 6.806983] systemd-logind[533]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 6.685396] systemd[1]: nscd.service: Deactivated successfully. machine # [ 6.808093] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 6.809286] dbus-broker-launch[539]: Looking up NSS user entry for 'systemd-timesync'... sshClient # [ 6.815778] systemd[1]: Finished First Boot Home Area Wizard. machine # [ 6.813477] dbus-broker-launch[539]: NSS returned no entry for 'systemd-timesync' machine # [ 6.814709] dbus-broker-launch[539]: Invalid user-name in /nix/store/x660r4qrp4cdrgimrljdm72c521k01y2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 6.816830] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.818342] systemd-logind[542]: New seat seat0. machine # [ 6.961890] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 6.962572] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 6.825280] systemd[1]: Started User Login Management. machine # [ 6.826333] systemd-logind[542]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 6.827601] systemd-logind[542]: Watching system buttons on /dev/input/event2 (Power Button) sshClient # [ 6.832503] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 6.832332] systemd[1]: Starting linger-users.service... machine # [ 6.835973] systemd[1]: Started D-Bus System Message Bus. sshClient # [ 6.840372] systemd[1]: Finished linger-users.service. sshClient # [ 6.846435] systemd[1]: Reached target First Boot Complete. machine # [ 6.842265] nsncd[606]: Oct 12 21:45:39.199 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 6.850699] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.851585] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.852732] systemd[1]: Reached target User and Group Name Lookups. sshClient # [ 6.870269] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 6.880669] systemd[1]: Finished resolvconf update. machine # [ 6.881518] systemd[1]: Reached target Preparation for Network. machine # [ 6.883670] dbus-broker-launch[539]: Ready machine # [ 6.891097] systemd[1]: Starting DHCP Client... machine # [ 6.896070] systemd[1]: Starting Address configuration of eth1... machine # [ 6.904196] systemd[1]: Starting Extra networking commands.... machine # [ 7.045092] ppdev: user-space parallel port driver machine # [ 6.937379] systemd-logind[542]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 6.941736] systemd[1]: Started Home Area Manager. sshClient # [ 6.949433] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 6.962068] systemd[1]: Finished Home Area Activation. machine # [ 6.970249] systemd[1]: Starting First Boot Home Area Wizard... machine # [ 6.980056] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.987689] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.000563] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 7.006570] systemd[1]: Finished linger-users.service. sshClient # [ 7.100122] ppdev: user-space parallel port driver sshClient # [ 7.171984] Console: switching to colour frame buffer device 160x50 sshClient # [ 7.195223] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) sshClient # [ 7.223839] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) sshClient # [ 7.246990] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device sshClient # [ 6.978832] network-addresses-eth1-start[612]: adding address 192.168.1.2/24... done sshClient # [ 7.108623] network-addresses-eth1-start[612]: adding address 2001:db8:1::2/64... done sshClient # [ 7.109990] systemd[1]: Finished Address configuration of eth1. sshClient # [ 7.115885] dhcpcd[628]: dhcpcd-10.3.2 starting sshClient # [ 7.118622] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.122645] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 7.125619] dhcpcd[682]: dev: loaded udev sshClient # [ 7.137271] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.141324] systemd[1]: Finished Extra networking commands.. sshClient # [ 7.142185] systemd[1]: Reached target Network. sshClient # [ 7.147638] systemd[1]: Starting Permit User Sessions... machine # [ 7.242889] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 7.271142] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 7.316369] Console: switching to colour frame buffer device 160x50 machine # [ 7.333214] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 7.027428] systemd[1]: Starting Virtual Console Setup... machine # [ 7.198330] systemd[1]: Finished Address configuration of eth1. machine # [ 7.199330] network-addresses-eth1-start[633]: adding address 192.168.1.1/24... done machine # [ 7.203532] network-addresses-eth1-start[633]: adding address 2001:db8:1::1/64... done machine # [ 7.211347] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.217315] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 7.362476] 8021q: 802.1Q VLAN Support v1.8 sshClient # [ 7.362955] 8021q: adding VLAN 0 to HW filter on device eth1 sshClient # [ 7.230717] systemd[1]: Finished Permit User Sessions. sshClient # [ 7.239912] systemd[1]: Started Getty on tty1. machine # [ 7.240375] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.244167] systemd[1]: Reached target Login Prompts. sshClient # [ 7.417994] kvm_amd: TSC scaling supported sshClient # [ 7.421454] kvm_amd: Nested Virtualization enabled sshClient # [ 7.421939] kvm_amd: Nested Paging enabled sshClient # [ 7.422465] kvm_amd: LBR virtualization supported sshClient # [ 7.422927] kvm_amd: Virtual VMLOAD VMSAVE supported sshClient # [ 7.423434] kvm_amd: Virtual GIF supported sshClient # [ 7.423831] kvm_amd: Virtual NMI enabled sshClient # [ 7.289401] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 7.310157] systemd[1]: Created slice Slice /system/systemd-mute-console. machine # [ 7.318058] systemd[1]: Started Console Output Muting Service (PID 635/UID 0). sshClient # [ 7.489050] cfg80211: Loading compiled-in X.509 certificates for regulatory database sshClient # [ 7.496271] EDAC MC: Ver: 3.0.0 machine # [ 7.354709] dhcpcd[651]: dhcpcd-10.3.2 starting sshClient # [ 7.511124] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' sshClient # [ 7.511849] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' sshClient # [ 7.514134] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 7.371301] systemd[1]: Finished Extra networking commands.. sshClient # [ 7.515113] cfg80211: failed to load regulatory.db machine # [ 7.372176] systemd[1]: Reached target Network. sshClient # [ 7.548608] 8021q: adding VLAN 0 to HW filter on device eth0 sshClient # [ 7.409556] dhcpcd[682]: eth0: waiting for carrier sshClient # [ 7.410801] dhcpcd[682]: libudev: received NULL device sshClient # [ 7.411566] dhcpcd[682]: libudev: received NULL device sshClient # [ 7.412512] dhcpcd[682]: eth0: carrier acquired sshClient # [ 7.417570] dhcpcd[682]: DUID 00:01:00:01:32:60:11:83:52:54:00:12:34:56 sshClient # [ 7.418815] dhcpcd[682]: eth0: IAID 00:12:34:56 sshClient # [ 7.419647] dhcpcd[682]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 7.430410] dhcpcd[707]: dev: loaded udev sshClient # [ 7.467562] systemd-vconsole-setup[686]: Configuration of first virtual console was skipped, ignoring remaining ones. sshClient # [ 7.469982] systemd[1]: Finished Virtual Console Setup. machine # [ 7.580284] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine: (finished: waiting for unit systemd-homed.service, in 8.41 seconds) machine: waiting for Please enter user name to create to appear on tty 1 machine # [ 7.848817] dhcpcd[707]: eth0: waiting for carrier machine # [ 7.849573] dhcpcd[707]: eth0: carrier acquired sshClient # [ 7.851969] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. sshClient # [ 7.858505] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.872335] dhcpcd[707]: DUID 00:01:00:01:32:60:11:84:52:54:00:12:34:56 machine # [ 7.873296] dhcpcd[707]: eth0: IAID 00:12:34:56 machine # [ 7.873987] dhcpcd[707]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 7.880252] dhcpcd[707]: eth0: soliciting a DHCP lease machine # [ 7.958490] dhcpcd[707]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 7.960149] dhcpcd[707]: eth0: probing address 10.0.2.15/24 sshClient # [ 8.130677] dhcpcd[682]: eth0: soliciting a DHCP lease sshClient # [ 8.290019] NET: Registered PF_PACKET protocol family sshClient # [ 8.156816] dhcpcd[682]: eth0: offered 10.0.2.15 from 10.0.2.2 sshClient # [ 8.161375] dhcpcd[682]: eth0: probing address 10.0.2.15/24 machine # [ 8.293910] sshd-keygen-start[560]: Generating public/private rsa key pair. machine # [ 8.295132] sshd-keygen-start[560]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine # [ 8.296255] sshd-keygen-start[560]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine # [ 8.297330] sshd-keygen-start[560]: The key fingerprint is: machine # [ 8.298414] sshd-keygen-start[560]: SHA256:HT+q21Tdq3XR0V0s3Ka/sMj7aJTqOfwkzbp4MvXf2JA root@machine machine # [ 8.299560] sshd-keygen-start[560]: The key's randomart image is: machine # [ 8.300439] sshd-keygen-start[560]: +---[RSA 4096]----+ machine # [ 8.301148] sshd-keygen-start[560]: | . o.| machine # [ 8.301822] sshd-keygen-start[560]: | o B| machine # [ 8.302480] sshd-keygen-start[560]: | . =o| machine # [ 8.303166] sshd-keygen-start[560]: | . o ...o| machine # [ 8.303832] sshd-keygen-start[560]: | S . = .oo| machine # [ 8.304746] sshd-keygen-start[560]: | .o= o. +| machine # [ 8.305888] sshd-keygen-start[560]: | o.B+.Eooo| machine # [ 8.307080] sshd-keygen-start[560]: | o.O==..B..| machine # [ 8.308020] sshd-keygen-start[560]: | .B**++= o | machine # [ 8.308947] sshd-keygen-start[560]: +----[SHA256]-----+ machine # [ 8.325845] systemd-vconsole-setup[692]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.331199] systemd[1]: Finished Virtual Console Setup. machine # [ 8.340200] sshd-keygen-start[741]: Generating public/private ed25519 key pair. machine # [ 8.341170] sshd-keygen-start[741]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine # [ 8.342325] sshd-keygen-start[741]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine # [ 8.343499] sshd-keygen-start[741]: The key fingerprint is: machine # [ 8.344255] sshd-keygen-start[741]: SHA256:HPv5Y7AHLvIYzqXJbNyyQYbvjlvAANYJeTyb2xwr5y4 root@machine machine # [ 8.345309] sshd-keygen-start[741]: The key's randomart image is: machine # [ 8.346113] sshd-keygen-start[741]: +--[ED25519 256]--+ machine # [ 8.346774] sshd-keygen-start[741]: |.o= . | machine # [ 8.347419] sshd-keygen-start[741]: |.o * | machine # [ 8.348088] sshd-keygen-start[741]: | o + . | machine # [ 8.348745] sshd-keygen-start[741]: | = o . o | machine # [ 8.349389] sshd-keygen-start[741]: | B = S | machine # [ 8.350056] sshd-keygen-start[741]: | o X .o. | machine # [ 8.350715] sshd-keygen-start[741]: | +.=...o+ | machine # [ 8.351377] sshd-keygen-start[741]: | E X=Bo o.+ | machine # [ 8.352088] sshd-keygen-start[741]: | ==%=.. o.. | machine # [ 8.352756] sshd-keygen-start[741]: +----[SHA256]-----+ machine # [ 8.355208] systemd[1]: sshd-keygen.service: Deactivated successfully. machine # [ 8.356339] systemd[1]: Finished SSH Host Keys Generation. machine # [ 8.359768] systemd[1]: Starting SSH Daemon... machine # [ 8.383620] sshd[743]: Server listening on 0.0.0.0 port 22. machine # [ 8.385058] sshd[743]: Server listening on :: port 22. machine # [ 8.385791] systemd[1]: Started SSH Daemon. machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 1.11 seconds) machine: sending keys 'test-homed-user\n' 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 sshClient # [ 9.741289] dhcpcd[682]: eth0: soliciting an IPv6 router sshClient # [ 9.744297] dhcpcd[682]: eth0: Router Advertisement from fe80::2 sshClient # [ 9.746527] dhcpcd[682]: eth0: adding address fec0::5054:ff:fe12:3456/64 sshClient # [ 9.748692] dhcpcd[682]: eth0: adding route to fec0::/64 sshClient # [ 9.750471] dhcpcd[682]: eth0: adding default route via fe80::2 machine # [ 9.794270] dhcpcd[707]: eth0: soliciting an IPv6 router machine # [ 9.797334] dhcpcd[707]: eth0: Router Advertisement from fe80::2 machine # [ 9.799533] dhcpcd[707]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 9.801806] dhcpcd[707]: eth0: adding route to fec0::/64 machine # [ 9.803734] dhcpcd[707]: eth0: adding default route via fe80::2 machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.10 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: (finished: waiting for (repeat) to appear on tty 1, in 1.08 seconds) machine: sending keys 'foobarfoo\n' machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds) machine: waiting for unit systemd-homed-firstboot.service machine # [ 12.685538] dhcpcd[707]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 12.688472] dhcpcd[707]: eth0: adding route to 10.0.2.0/24 machine # [ 12.690837] dhcpcd[707]: eth0: adding default route via 10.0.2.2 machine # [ 12.777357] systemd[1]: Started DHCP Client. sshClient # [ 13.781696] dhcpcd[682]: eth0: leased 10.0.2.15 for 86400 seconds sshClient # [ 13.782959] dhcpcd[682]: eth0: adding route to 10.0.2.0/24 sshClient # [ 13.783813] dhcpcd[682]: eth0: adding default route via 10.0.2.2 sshClient # [ 13.840366] systemd[1]: Started DHCP Client. sshClient # [ 13.842396] systemd[1]: Reached target Multi-User System. sshClient # [ 13.843425] systemd[1]: Startup finished in 851ms (kernel) + 3.171s (initrd) + 9.819s (userspace) = 13.843s. machine # [ 21.546357] systemd-homed[519]: Generating key pair for signing local user identity records. machine # [ 21.550809] systemd-homed[519]: Successfully created Ed25519 key pair. machine # [ 21.563731] systemd-homed[519]: test-homed-user: changing state absent → creating machine # [ 21.613251] systemd-homework[880]: Using automatic default storage of 'luks'. machine # [ 21.617884] systemd-homework[880]: Sizing home to 83% of available disk space, which is 743M. machine # [ 21.619057] systemd-homework[880]: Allocating image file completed. machine # [ 21.650154] systemd-homework[880]: Writing of partition table completed. machine # [ 21.654305] systemd-homework[880]: Setting up loopback device /dev/loop0 completed. machine # [ 23.188761] systemd-homework[880]: LUKS formatting completed. machine # [ 25.899634] systemd-homework[880]: Writing password to LUKS keyslot 0 completed. machine # [ 26.120725] systemd-homework[880]: LUKS activation by volume key succeeded. machine # [ 26.228618] systemd-homework[880]: Writing user record as LUKS token completed. machine # [ 26.232398] systemd-homework[880]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 26.235472] systemd-homework[880]: Formatting /dev/mapper/home-test-homed-user as btrfs machine # [ 26.601954] systemd[1]: proc-918-mounts.mount: Deactivated successfully. machine # [ 26.603416] systemd-homework[880]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid c5e1469c-26b4-4ad7-84a4-c9b8290c4d7c) machine # [ 26.605371] systemd-homework[880]: Formatting file system completed. machine # [ 26.638520] systemd-homework[880]: Mounting file system completed. machine # [ 26.641037] systemd-homework[880]: Skeleton directory /etc/skel missing, ignoring. machine # [ 26.642084] systemd-homework[880]: Wrote embedded .identity file. machine # [ 26.642913] systemd-homework[880]: Replaced embedded blob dir with contents of system blob dir. machine # [ 26.644067] systemd-homework[880]: Recursive changing of ownership completed. machine # [ 26.645027] systemd-homework[880]: Changed top-level directory access mode to 0700. machine # [ 26.672845] systemd-homework[880]: Synchronized disk. machine # [ 26.674082] systemd-homework[880]: Discarded unused 651.8M. machine # [ 26.682374] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 26.691563] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 26.704510] (udev-worker)[908]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.706975] (udev-worker)[908]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.709643] (udev-worker)[908]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.712136] systemd-homed[519]: block device /sys/devices/virtual/block/loop0 has been removed. machine # [ 26.714888] systemd-homework[880]: Moved image file into place. machine # [ 26.717828] systemd-homework[880]: Creation completed. machine # [ 26.718548] systemd-homework[880]: Image size is 743M, file system size is 725M, file system payload size is 725M, file system free is 718.9M. machine # [ 26.726687] systemd-homed[519]: test-homed-user: changing state creating → inactive machine # [ 26.732557] systemd[1]: systemd-mute-console@0-1-635_636-0.service: Deactivated successfully. machine # [ 26.735784] systemd[1]: Finished First Boot Home Area Wizard. machine # [ 26.739532] systemd[1]: Reached target First Boot Complete. machine # [ 26.742195] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 26.745243] systemd[1]: Starting Permit User Sessions... machine # [ 26.770587] systemd[1]: Finished Permit User Sessions. machine # [ 26.774484] systemd[1]: Started Getty on tty1. machine # [ 26.776526] systemd[1]: Reached target Login Prompts. machine # [ 26.777959] systemd[1]: Reached target Multi-User System. machine # [ 26.915685] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 26.921823] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 26.926694] systemd[1]: Startup finished in 856ms (kernel) + 3.145s (initrd) + 22.923s (userspace) = 26.926s. machine: (finished: waiting for unit systemd-homed-firstboot.service, in 15.75 seconds) (finished: subtest: create systemd-homed user on first boot prompt, in 27.81 seconds) machine: must succeed: homectl update test-homed-user --offline -G wheel machine # [ 27.167278] systemd-homed[519]: test-homed-user: changing state inactive → updating machine # [ 27.171403] systemd-homework[960]: Offline update requested. Not touching embedded records. machine # [ 27.173404] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 27.180637] systemd-homed[519]: 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.17 seconds) machine: waiting for Password: to appear on tty 1 machine # [ 27.538839] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 27.543513] systemd-homework[975]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 27.548455] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 27.550388] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 27.551568] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 27.552984] systemd-homed[519]: Home test-homed-user already deactivated, no automatic deactivation needed. machine: (finished: waiting for Password: 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 success: pgrep -u test-homed-user -t tty1 bash machine # [ 28.693139] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 28.717814] systemd-homework[987]: Provided password unlocks user record. machine # [ 28.726875] systemd-homework[987]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 28.761606] systemd-homework[987]: Allocated additional 651.8M. machine # [ 28.920887] loop1: detected capacity change from 0 to 1517568 machine # [ 28.783841] systemd-homework[987]: Setting up loopback device /dev/loop1 completed. machine # [ 29.656216] systemd-homework[987]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 29.684545] systemd-homework[987]: Provided password unlocks user record. machine # [ 29.689915] systemd-homework[987]: Probing file system completed (found btrfs). machine # [ 29.692228] systemd-homework[987]: No fsck for file system btrfs installed, ignoring. machine # [ 29.833051] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (987) machine # [ 29.835461] BTRFS info (device dm-0): first mount of filesystem c5e1469c-26b4-4ad7-84a4-c9b8290c4d7c machine # [ 29.836574] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 29.841082] BTRFS info (device dm-0): enabling free space tree machine # [ 29.841832] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 29.704208] systemd-homework[987]: Mounting file system completed. machine # [ 29.705966] systemd-homework[987]: Discovered used loopback device /dev/loop1. machine # [ 29.707113] systemd-homework[987]: offset = 1048576, size = 776994816, image = 779091968 machine # [ 29.716892] systemd-homework[987]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M. machine # [ 29.719091] systemd-homework[987]: Growing of image file from 743M to 896M completed. machine # [ 29.861670] loop1: detected capacity change from 1517568 to 1830912 machine # [ 29.724585] systemd-homework[987]: Refreshing loop device size completed. machine # [ 29.741048] systemd-homework[987]: Growing of partition completed. machine # [ 29.898061] async_tx: api initialized (async) machine # [ 29.790081] systemd-homework[987]: LUKS device growing completed. machine # [ 29.937414] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 920649728 machine # [ 29.800028] systemd-homework[987]: File system resizing from 725M to 878M completed. machine # [ 29.801196] systemd-homework[987]: Synchronized disk. machine # [ 29.803057] systemd-homework[987]: Synchronized disk. machine # [ 29.803764] systemd-homework[987]: Resizing completed. machine # [ 29.804440] systemd-homework[987]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 29.805911] systemd-homework[987]: Read embedded .identity file. machine # [ 29.824318] systemd-homework[987]: Provided password unlocks user record. machine # [ 29.825409] systemd-homework[987]: Reconciling header user identity completed (host version was newer). machine # [ 29.826637] systemd-homework[987]: Reconciling embedded user identity completed (host version was newer). machine # [ 29.842447] systemd-homework[987]: Wrote LUKS header user record. machine # [ 29.843382] systemd-homework[987]: Wrote embedded .identity file. machine # [ 29.844211] systemd-homework[987]: Replaced embedded blob dir with contents of system blob dir. machine # [ 29.845334] systemd-homework[987]: Recursive changing of ownership not necessary, skipped. machine # [ 29.851606] systemd-homework[987]: Synchronized disk. machine # [ 29.853513] systemd-homework[987]: Moving to final mount point /home/test-homed-user completed. machine # [ 29.871629] systemd-homework[987]: Activation completed. machine # [ 29.873303] systemd-homework[987]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 29.882831] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 29.889688] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → active machine # [ 29.890992] login[951]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired. machine # [ 29.897429] systemd-homed[519]: test-homed-user: changing state active → resizing-while-active machine # [ 29.907179] systemd-homework[1029]: Successfully acquired home volume key from kernel keyring. machine # [ 29.908633] systemd-homework[1029]: LUKS volume key from keyring unlocks user record. machine # [ 29.965622] login[951]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0) machine # [ 29.990815] systemd-homework[1029]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 30.016269] systemd[1]: Created slice Slice /user/60388. machine # [ 30.019238] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 30.037270] systemd-logind[542]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'. machine # [ 30.089168] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 30.106484] systemd[1]: Starting User Manager for UID 60388... machine # [ 30.153419] (systemd)[1035]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 30.201106] (systemd)[1035]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 30.207051] systemd-logind[542]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 30.258207] systemd-homework[1029]: Successfully re-activated LUKS device. machine # [ 30.260523] systemd-homework[1029]: LUKS volume key from keyring unlocks user record. machine # [ 30.262838] systemd-homework[1029]: Discovered used loopback device /dev/loop1. machine # [ 30.263953] systemd-homework[1029]: Read embedded .identity file. machine # [ 30.264851] systemd-homework[1029]: LUKS volume key from keyring unlocks user record. machine # [ 30.265855] systemd-homework[1029]: Reconciling header user identity completed (host version was newer). machine # [ 30.267018] systemd-homework[1029]: Reconciling embedded user identity completed (host version was newer). machine # [ 30.268148] systemd-homework[1029]: offset = 1048576, size = 937426944, image = 939524096 machine # [ 30.270903] systemd[1035]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.312869] systemd-homework[1029]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M. machine # [ 30.315108] systemd-homework[1029]: Wrote embedded .identity file. machine # [ 30.316837] systemd-homework[1029]: Replaced embedded blob dir with contents of system blob dir. machine # [ 30.318309] systemd-homework[1029]: Backing file is fully allocated already. machine # [ 30.464579] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 782237696 machine # [ 30.328065] systemd-homework[1029]: File system resizing from 878M to 746M completed. machine # [ 30.330412] systemd-homework[1029]: Synchronized disk. machine # [ 30.369146] systemd-homework[1029]: LUKS device shrinking completed. machine # [ 30.509668] loop1: detected capacity change from 1830912 to 1560576 machine # [ 30.373620] systemd-homework[1029]: Refreshing loop device size completed. machine # [ 30.374647] systemd-homework[1029]: Shrinking of image file completed. machine # [ 30.397623] systemd-homework[1029]: Shrinking of partition completed. machine # [ 30.405490] systemd[1035]: Queued start job for default target Main User Target. machine # [ 30.407463] systemd[1035]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.412183] systemd[1035]: Created slice User Application Slice. machine # [ 30.413262] systemd[1035]: Started Daily Cleanup of User's Temporary Directories. machine # [ 30.414378] systemd[1035]: Reached target Paths. machine # [ 30.415730] systemd[1035]: Reached target Timers. machine # [ 30.417916] systemd[1035]: Starting D-Bus User Message Bus Socket... machine # [ 30.420604] systemd[1035]: Starting Create User Files and Directories... machine # [ 30.439182] systemd-homework[1029]: Wrote LUKS header user record. machine # [ 30.440216] systemd-homework[1029]: Synchronized disk. machine # [ 30.444935] systemd-homework[1029]: Resizing completed. machine # [ 30.446617] systemd-homework[1029]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 30.462558] systemd[1035]: Finished Create User Files and Directories. machine # [ 30.464610] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 30.470748] systemd-homed[519]: test-homed-user: changing state resizing-while-active → active machine # [ 30.472508] systemd-homed[519]: Rebalancing complete. machine # [ 30.483471] systemd[1035]: Listening on D-Bus User Message Bus Socket. machine # [ 30.485673] systemd[1035]: Reached target Sockets. machine # [ 30.486388] systemd[1035]: Reached target Basic System. machine # [ 30.487145] systemd[1]: Started User Manager for UID 60388. machine # [ 30.490546] systemd[1035]: Starting Run user-specific NixOS activation... machine # [ 30.492437] systemd[1]: Started Session 1 of User test-homed-user. machine # [ 30.523841] systemd[1035]: Finished Run user-specific NixOS activation. machine # [ 30.525450] systemd[1035]: Reached target Main User Target. machine # [ 30.526964] systemd[1035]: Startup finished in 279ms. machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.18 seconds) machine: sending keys 'whoami > /tmp/2\n' machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.17 seconds) machine: waiting for file '/tmp/2' machine: (finished: waiting for file '/tmp/2', in 1.05 seconds) machine: must succeed: cat /tmp/2 machine: (finished: must succeed: cat /tmp/2, in 0.02 seconds) (finished: subtest: login as homed user, in 4.78 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.10 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 # [ 33.480649] login[691]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0) sshClient # [ 33.525773] systemd-logind[533]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'. sshClient # [ 33.538228] systemd[1]: Created slice Slice /user/1000. sshClient # [ 33.538983] systemd[1]: Starting User Runtime Directory /run/user/1000... sshClient # [ 33.572673] systemd[1]: Finished User Runtime Directory /run/user/1000. sshClient # [ 33.575891] systemd[1]: Starting User Manager for UID 1000... sshClient # [ 33.599430] (systemd)[810]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0) sshClient # [ 33.605071] systemd-logind[533]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'. sshClient # [ 33.621252] systemd[810]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 33.723679] systemd[810]: Queued start job for default target Main User Target. sshClient # [ 33.725819] systemd[810]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 33.728129] systemd[810]: Created slice User Application Slice. sshClient # [ 33.729341] systemd[810]: Started Daily Cleanup of User's Temporary Directories. sshClient # [ 33.730906] systemd[810]: Reached target Paths. sshClient # [ 33.732335] systemd[810]: Reached target Timers. sshClient # [ 33.734449] systemd[810]: Starting D-Bus User Message Bus Socket... sshClient # [ 33.738228] systemd[810]: Starting Create User Files and Directories... sshClient # [ 33.771988] systemd[810]: Finished Create User Files and Directories. sshClient # [ 33.793490] systemd[810]: Listening on D-Bus User Message Bus Socket. sshClient # [ 33.794506] systemd[810]: Reached target Sockets. sshClient # [ 33.795266] systemd[810]: Reached target Basic System. sshClient # [ 33.795992] systemd[1]: Started User Manager for UID 1000. sshClient # [ 33.799563] systemd[810]: Starting Run user-specific NixOS activation... sshClient # [ 33.804858] systemd[1]: Started Session 1 of User test-normal-user. sshClient # [ 33.833350] systemd[810]: Finished Run user-specific NixOS activation. sshClient # [ 33.834368] systemd[810]: Reached target Main User Target. sshClient # [ 33.836207] systemd[810]: Startup finished in 220ms. sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.11 seconds) sshClient: sending keys 'whoami > /tmp/1\n' sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.17 seconds) sshClient: waiting for file '/tmp/1' sshClient: (finished: waiting for file '/tmp/1', in 1.05 seconds) sshClient: must succeed: cat /tmp/1 sshClient: (finished: must succeed: cat /tmp/1, in 0.03 seconds) (finished: subtest: login as regular user, in 3.77 seconds) subtest: add homed ssh authorized key sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n' sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.49 seconds) sshClient: waiting for file '/tmp/id_ed25519.pub' sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.06 seconds) sshClient: must succeed: cat /tmp/id_ed25519.pub sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.03 seconds) machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICbb54lp/X3h3DBgOi6IpJ8GyKzw7L9YO6mcfUiC3bpc test-normal-user@sshClient' machine # [ 37.381160] systemd-homed[519]: test-homed-user: changing state active → updating-while-active machine # [ 37.390520] systemd-homework[1084]: Offline update requested. Not touching embedded records. machine # [ 37.425457] systemd-homed[519]: test-homed-user: changing state updating-while-active → active machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICbb54lp/X3h3DBgOi6IpJ8GyKzw7L9YO6mcfUiC3bpc test-normal-user@sshClient', in 0.12 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.04 seconds) (finished: subtest: add homed ssh authorized key, in 1.74 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.10 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/ia9s7i2873j5j7hl958fm47b38lcaf4i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 573 machine: must succeed: sleep 4.0 machine # [ 40.268033] systemd-homed[519]: test-homed-user: changing state active → passwd-while-active machine # [ 40.973132] systemd-homework[1123]: No valid password for LUKS superblock. machine # [ 43.286243] systemd-homed[519]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 43.290549] systemd-homed[519]: 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 # [ 44.405366] systemd-homed[519]: test-homed-user: changing state active → passwd-while-active machine # [ 45.716409] systemd-homework[1128]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 45.844589] systemd-homework[1128]: Successfully re-activated LUKS device. machine # [ 45.882826] systemd-homework[1128]: Provided password unlocks user record. machine # [ 45.884256] systemd-homework[1128]: Discovered used loopback device /dev/loop1. machine # [ 45.885358] systemd-homework[1128]: Read embedded .identity file. machine # [ 45.922073] systemd-homework[1128]: Provided password unlocks user record. machine # [ 45.923061] systemd-homework[1128]: Reconciling header user identity completed (host version was newer). machine # [ 45.924204] systemd-homework[1128]: Reconciling embedded user identity completed (host version was newer). machine # [ 49.576360] systemd-homework[1128]: Added LUKS key slot 1. machine # [ 49.613550] systemd-homework[1128]: Destroyed LUKS key slot 0. machine # [ 49.625319] systemd-homework[1128]: Wrote LUKS header user record. machine # [ 49.626509] systemd-homework[1128]: Wrote embedded .identity file. machine # [ 49.627683] systemd-homework[1128]: Replaced embedded blob dir with contents of system blob dir. machine # [ 49.635404] systemd-homework[1128]: Synchronized disk. machine # [ 49.640289] systemd-homework[1128]: Everything completed. machine # [ 49.649542] systemd-homed[519]: test-homed-user: changing state passwd-while-active → active machine # [ 49.651591] passwd[1097]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user. machine: (finished: waiting for file '/tmp/3', in 6.15 seconds) machine: must succeed: cat /tmp/3 machine: (finished: must succeed: cat /tmp/3, in 0.02 seconds) (finished: subtest: change homed user password, in 12.98 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 # [ 50.921596] systemd-homed[519]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 50.930664] systemd-homework[1169]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 50.940850] systemd-homed[519]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 50.944975] systemd-homed[519]: 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.03 seconds) machine: waiting for success: grep uid=0 /tmp/4 machine # [ 51.955683] systemd-homed[519]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 51.991546] systemd-homework[1185]: Provided password unlocks user record. machine # [ 52.659179] systemd-homework[1185]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 52.788683] systemd-homework[1185]: Successfully re-activated LUKS device. machine # [ 52.809517] systemd-homework[1185]: Provided password unlocks user record. machine # [ 52.810932] systemd-homework[1185]: Discovered used loopback device /dev/loop1. machine # [ 52.813107] systemd-homework[1185]: Read embedded .identity file. machine # [ 52.830775] systemd-homework[1185]: Provided password unlocks user record. machine # [ 52.831810] systemd-homework[1185]: Reconciling user identities completed (host and header version were identical). machine # [ 52.833173] systemd-homework[1185]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 52.843741] systemd-homework[1185]: Everything completed. machine # [ 52.850652] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 52.857971] sudo[1167]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired. machine # [ 52.860318] systemd-homed[519]: test-homed-user: changing state authenticating-for-acquire → active machine # [ 52.866619] sudo[1167]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id machine # [ 52.885499] sudo[1167]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388) machine # [ 52.896153] sudo[1167]: pam_unix(sudo:session): session closed for user root machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.06 seconds) (finished: subtest: escalate to root from homed user, in 2.51 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 # [ 53.040421] login[951]: pam_unix(login:session): session closed for user test-homed-user machine # [ 53.042515] login[951]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 53.046431] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 53.052088] systemd[1]: session-1.scope: Deactivated successfully. machine # [ 53.054532] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. machine # [ 53.058314] systemd-logind[542]: Session 1 logged out. Waiting for processes to exit. machine # [ 53.060189] systemd[1]: Started Getty on tty1. machine # [ 53.062089] systemd-logind[542]: Removed session 1. machine # [ 63.102255] systemd[1]: Stopping User Manager for UID 60388... machine # [ 63.107549] systemd[1035]: Activating special unit Exit the Session... machine # [ 63.111783] systemd[1035]: Stopped target Main User Target. machine # [ 63.115698] systemd[1035]: Stopped Run user-specific NixOS activation. machine # [ 63.117905] systemd[1035]: Stopped target Basic System. machine # [ 63.121709] systemd[1035]: Stopped target Paths. machine # [ 63.124551] systemd[1035]: Stopped target Sockets. machine # [ 63.127849] systemd[1035]: Stopped target Timers. machine # [ 63.131367] systemd[1035]: Stopped Daily Cleanup of User's Temporary Directories. machine # [ 63.134991] systemd[1035]: Closed D-Bus User Message Bus Socket. machine # [ 63.137712] systemd[1035]: Stopped Create User Files and Directories. machine # [ 63.141669] systemd[1035]: Removed slice User Application Slice. machine # [ 63.144354] systemd[1035]: Reached target Shutdown. machine # [ 63.147593] systemd[1035]: Finished Exit the Session. machine # [ 63.150744] systemd[1035]: Reached target Exit the Session. machine # [ 63.157553] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 63.162992] systemd-homed[519]: test-homed-user: changing state active → deactivating machine # [ 63.167689] systemd-logind[542]: Removed session 2. machine # [ 63.171129] systemd[1]: user@60388.service: Deactivated successfully. machine # [ 63.173108] systemd[1]: Stopped User Manager for UID 60388. machine # [ 63.175528] systemd-homework[1264]: Successfully acquired home volume key from kernel keyring. machine # [ 63.177446] systemd-homework[1264]: Discarded unused 673.3M. machine # [ 63.187322] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully. machine # [ 63.190977] systemd-homework[1264]: Syncing completed. machine # [ 63.195575] systemd[1]: Stopping User Runtime Directory /run/user/60388... machine # [ 63.231593] systemd[1]: run-user-60388.mount: Deactivated successfully. machine # [ 63.234046] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully. machine # [ 63.237103] systemd[1]: Stopped User Runtime Directory /run/user/60388. machine # [ 63.255667] systemd-homework[1264]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 63.385417] systemd-homework[1264]: Successfully re-activated LUKS device. machine # [ 63.387094] systemd-homework[1264]: Discovered used loopback device /dev/loop1. machine # [ 63.388124] systemd-homework[1264]: offset = 1048576, size = 799014912, image = 801112064 machine # [ 63.406159] systemd-homework[1264]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M. machine # [ 63.407693] systemd-homework[1264]: Allocated additional 673.3M. machine # [ 63.554610] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 268435456 machine # [ 63.417363] systemd-homework[1264]: File system resizing from 746M to 256M completed. machine # [ 63.418589] systemd-homework[1264]: Synchronized disk. machine # [ 63.506463] systemd-homework[1264]: LUKS device shrinking completed. machine # [ 63.647696] loop1: detected capacity change from 1560576 to 557056 machine # [ 63.510645] systemd-homework[1264]: Refreshing loop device size completed. machine # [ 63.512216] systemd-homework[1264]: Shrinking of image file completed. machine # [ 63.531064] systemd-homework[1264]: Shrinking of partition completed. machine # [ 63.531939] systemd-homework[1264]: Synchronized disk. machine # [ 63.532619] systemd-homework[1264]: Resizing completed. machine # [ 63.533340] systemd-homework[1264]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M. machine # [ 63.673386] BTRFS info (device dm-0): last unmount of filesystem c5e1469c-26b4-4ad7-84a4-c9b8290c4d7c machine # [ 63.537816] systemd-homework[1264]: Unmounting completed. machine # [ 63.539415] systemd-homework[1264]: Discovered used LUKS device /dev/mapper/home-test-homed-user. machine # [ 63.540666] systemd-homework[1264]: Device home-test-homed-user is not active. machine # [ 63.550372] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 63.556786] systemd-homework[1264]: Everything completed. machine # [ 63.564342] systemd-homed[519]: test-homed-user: changing state deactivating → inactive machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 11.46 seconds) (finished: subtest: log out and deactivate homed user's home area, in 11.51 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 # [ 66.310249] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 66.318881] systemd-homework[1298]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 66.328874] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 66.332071] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 66.334288] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 66.337926] systemd-homed[519]: Home test-homed-user already deactivated, no automatic deactivation needed. machine # [ 66.341681] sshd-session[1294]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error machine # [ 66.344713] sshd-session[1294]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation. machine # [ 66.348226] sshd-session[1294]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 59314 ssh2: ED25519 SHA256:jmyWVCq9ZDS/51rTYn3yaRhjVObOkVH+yoTSx09U+6M machine # [ 66.385528] sshd-session[1294]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 66.396977] systemd-logind[542]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'. machine # [ 66.400170] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 66.418609] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 66.423564] systemd[1]: Started Session 3 of User test-homed-user. machine # [ 66.439574] sshd-session[1294]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 66.443350] sshd-session[1294]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 66.459574] systemd-homed[519]: test-homed-user: changing state inactive → activating machine # [ 66.463299] systemd-homework[1304]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 66.470714] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 66.472605] systemd-homed[519]: test-homed-user: changing state activating → inactive sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.17 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 # [ 67.624722] systemd-homed[519]: test-homed-user: changing state inactive → activating machine # [ 67.668873] systemd-homework[1309]: Provided password unlocks user record. machine # [ 67.672616] systemd-homework[1309]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 67.677744] systemd-homework[1309]: Backing file is fully allocated already. machine # [ 67.821376] loop1: detected capacity change from 0 to 557056 machine # [ 67.684060] systemd-homework[1309]: Setting up loopback device /dev/loop1 completed. machine # [ 68.538881] systemd-homework[1309]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 68.563864] systemd-homework[1309]: Provided password unlocks user record. machine # [ 68.570234] systemd-homework[1309]: Probing file system completed (found btrfs). machine # [ 68.571631] systemd-homework[1309]: No fsck for file system btrfs installed, ignoring. machine # [ 68.712076] BTRFS: device label test-homed-user devid 1 transid 17 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1309) machine # [ 68.714071] BTRFS info (device dm-0): first mount of filesystem c5e1469c-26b4-4ad7-84a4-c9b8290c4d7c machine # [ 68.715365] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 68.721085] BTRFS info (device dm-0): enabling free space tree machine # [ 68.721682] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 68.585396] systemd-homework[1309]: Mounting file system completed. machine # [ 68.587260] systemd-homework[1309]: Discovered used loopback device /dev/loop1. machine # [ 68.588338] systemd-homework[1309]: offset = 1048576, size = 285212672, image = 287309824 machine # [ 68.601673] systemd-homework[1309]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M. machine # [ 68.603328] systemd-homework[1309]: Growing of image file from 274M to 764M completed. machine # [ 68.744299] loop1: detected capacity change from 557056 to 1560576 machine # [ 68.610184] systemd-homework[1309]: Refreshing loop device size completed. machine # [ 68.631550] systemd-homework[1309]: Growing of partition completed. machine # [ 68.660475] systemd-homework[1309]: LUKS device growing completed. machine # [ 68.804821] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 782237696 machine # [ 68.667621] systemd-homework[1309]: File system resizing from 256M to 746M completed. machine # [ 68.670239] systemd-homework[1309]: Synchronized disk. machine # [ 68.671101] systemd-homework[1309]: Synchronized disk. machine # [ 68.671834] systemd-homework[1309]: Resizing completed. machine # [ 68.672673] systemd-homework[1309]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 68.674276] systemd-homework[1309]: Read embedded .identity file. machine # [ 68.692543] systemd-homework[1309]: Provided password unlocks user record. machine # [ 68.694151] systemd-homework[1309]: Reconciling user identities completed (host and header version were identical). machine # [ 68.695487] systemd-homework[1309]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 68.697473] systemd-homework[1309]: Recursive changing of ownership not necessary, skipped. machine # [ 68.698960] systemd-homework[1309]: Synchronized disk. machine # [ 68.700389] systemd-homework[1309]: Moving to final mount point /home/test-homed-user completed. machine # [ 68.723786] systemd-homework[1309]: Activation completed. machine # [ 68.724750] systemd-homework[1309]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 68.736259] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 68.743870] systemd-homed[519]: test-homed-user: changing state activating → active machine # [ 68.754320] systemd[1]: Starting User Manager for UID 60388... machine # [ 68.776990] (systemd)[1351]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 68.815232] (systemd)[1351]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 68.821305] systemd-logind[542]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 68.838449] systemd[1351]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.917778] systemd[1351]: Queued start job for default target Main User Target. machine # [ 68.920711] systemd[1351]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.923384] systemd[1351]: Created slice User Application Slice. machine # [ 68.925181] systemd[1351]: Started Daily Cleanup of User's Temporary Directories. machine # [ 68.926230] systemd[1351]: Reached target Paths. machine # [ 68.926952] systemd[1351]: Reached target Timers. machine # [ 68.929129] systemd[1351]: Starting D-Bus User Message Bus Socket... machine # [ 68.930897] systemd[1351]: Starting Create User Files and Directories... machine # [ 68.956701] systemd[1351]: Finished Create User Files and Directories. machine # [ 68.959630] systemd[1351]: Listening on D-Bus User Message Bus Socket. machine # [ 68.961319] systemd[1351]: Reached target Sockets. machine # [ 68.962106] systemd[1351]: Reached target Basic System. machine # [ 68.963599] systemd[1]: Started User Manager for UID 60388. machine # [ 68.965915] systemd[1351]: Starting Run user-specific NixOS activation... machine # [ 69.000185] systemd[1351]: Finished Run user-specific NixOS activation. machine # [ 69.001575] systemd[1351]: Reached target Main User Target. machine # [ 69.003078] systemd[1351]: Startup finished in 170ms. machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.16 seconds) sshClient: sending keys 'whoami > /tmp/5\n' sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.17 seconds) machine: waiting for file '/tmp/5' machine: (finished: waiting for file '/tmp/5', in 1.06 seconds) machine: must succeed: cat /tmp/5 machine: (finished: must succeed: cat /tmp/5, in 0.03 seconds) sshClient: sending keys 'exit\n' sshClient: (finished: sending keys 'exit\n', in 0.05 seconds) sshClient: sending keys 'exit\n' machine # [ 71.037755] sshd-session[1301]: Received disconnect from 2001:db8:1::2 port 59314:11: disconnected by user sshClient: (finished: sending keys 'exit\n', in 0.05 seconds) (finished: subtest: ssh as homed user, in 6.57 seconds) (finished: run the VM test script, in 72.08 seconds) machine # [ 71.043724] sshd-session[1301]: Disconnected from user test-homed-user 2001:db8:1::2 port 59314 machine # [ 71.054544] sshd-session[1294]: pam_unix(sshd:session): session closed for user test-homed-user machine # [ 71.061287] sshd-session[1294]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 71.072976] systemd[1]: session-3.scope: Deactivated successfully. machine # [ 71.082879] systemd-logind[542]: Session 3 logged out. Waiting for processes to exit. machine # [ 71.090177] systemd-logind[542]: Removed session 3. sshClient # [ 71.126745] login[691]: pam_unix(login:session): session closed for user test-normal-user sshClient # [ 71.131953] systemd[1]: getty@tty1.service: Deactivated successfully. sshClient # [ 71.138346] systemd[1]: session-1.scope: Deactivated successfully. sshClient # [ 71.139867] systemd[1]: session-1.scope: Consumed 145ms CPU time over 37.335s wall clock time, 9.5M memory peak, 12K written to disk, 21.1K incoming IP traffic, 20.1K outgoing IP traffic. sshClient # [ 71.143614] systemd-logind[533]: Session 1 logged out. Waiting for processes to exit. sshClient # [ 71.146201] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. sshClient # [ 71.149485] systemd[1]: Started Getty on tty1. sshClient # [ 71.152144] systemd-logind[533]: Removed session 1. test script finished in 72.30s 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-12T21:46:44Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-12T21:46:44Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-12T21:46: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-12T21:46:44Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-10-12T21:46:44Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-10-12T21:46:44Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.38 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