tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.01 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script start all VMs machine: starting vm sshClient: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 47) machine # Formatting '/build/vm-state-machine/tmp.N8jZHDrioO', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: 0366f8ce-a63c-499c-9a0c-53641e19b580 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-16T02:57:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-16T02:57:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-16T02:57:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-16T02:57:02Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-16T02:57:02Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-16T02:57:02Z INFO virtiofsd] Client connected, servicing requests sshClient: QEMU running (pid 48) sshClient # Disk image does not exist, creating the virtualisation disk image... sshClient # Formatting '/build/vm-state-sshClient/tmp.TlAKueKqcy', fmt=raw size=1073741824 sshClient # mke2fs 1.47.4 (6-Mar-2025) sshClient # Discarding device blocks: 0/262144 done sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes (finished: start all VMs, in 0.28 seconds) sshClient # Filesystem UUID: beb9b0a7-6b97-4823-a932-441fc96bb4ea sshClient # Superblock backups stored on blocks: sshClient # 32768, 98304, 163840, 229376 sshClient # sshClient # Allocating group tables: 0/8 done sshClient # Writing inode tables: 0/8 done sshClient # Creating journal (8192 blocks): done sshClient # Writing superblocks and filesystem accounting information: 0/8 done sshClient # sshClient # Virtualisation disk image created. sshClient # Starting virtiofs daemons... sshClient # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether subtest: create systemd-homed user on first boot prompt sshClient # [2026-10-16T02:57:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine: waiting for unit systemd-homed.service sshClient # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-16T02:57:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine: waiting for the VM to finish booting sshClient # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) sshClient # [2026-10-16T02:57:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether sshClient # [2026-10-16T02:57:02Z INFO virtiofsd] Waiting for vhost-user socket connection... sshClient # [2026-10-16T02:57:02Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-10-16T02:57:02Z INFO virtiofsd] Client connected, servicing requests sshClient # [2026-10-16T02:57:02Z INFO virtiofsd] Client connected, servicing requests sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) sshClient # sshClient # machine # machine # sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)... sshClient # sshClient # sshClient # sshClient # machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # sshClient # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # 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 # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # machine # Booting from ROM... sshClient # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/1k2q12hb0diqqqx41idaivn5zbdggnc9-nixos-system-machine-test/init regInfo=/nix/.ro-store/hi4gv2w3h2gdl4d4ln2vw8n4xryrvw3m-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000000] kvm-clock: using sched offset of 451254116 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.008 MHz processor machine # [ 0.000757] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000784] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000786] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002679] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002690] Using GB pages for direct mapping machine # [ 0.002759] RAMDISK: [mem 0x3e2b8000-0x3ffcffff] machine # [ 0.002767] ACPI: Early table checksum verification disabled machine # [ 0.002770] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002774] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002778] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002786] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002788] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002790] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002791] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002793] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002794] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002796] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002796] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002797] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002798] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002798] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002799] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002799] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003025] No NUMA configuration found machine # [ 0.003026] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003028] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005216] Zone ranges: machine # [ 0.005217] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005218] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005220] Normal empty machine # [ 0.005220] Device empty machine # [ 0.005221] Movable zone start for each node machine # [ 0.005222] Early memory node ranges machine # [ 0.005222] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005223] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005224] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005243] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005500] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.022461] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.022914] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.022925] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) sshClient # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 machine # [ 0.022951] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.022954] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.022955] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.022956] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) 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/hmfkww77dc18zp23rffmbyqxc3wjzirh-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/21ghiyfac61zdvqxjc878pcx2bi66ijj-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.022957] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) sshClient # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.022958] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.022960] ACPI: Using ACPI (MADT) for SMP configuration information sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.022961] ACPI: HPET id: 0x8086a201 base: 0xfed00000 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.022965] TSC deadline timer available machine # [ 0.022969] CPU topo: Max. logical packages: 1 sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.022970] CPU topo: Max. logical dies: 1 sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.022970] CPU topo: Max. dies per package: 1 machine # [ 0.022973] CPU topo: Max. threads per core: 1 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.022974] CPU topo: Num. cores per package: 1 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.022974] CPU topo: Num. threads per package: 1 sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.022975] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.022991] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.023018] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] sshClient # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.023020] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] sshClient # [ 0.000000] APIC: Static calls initialized sshClient # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.023021] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.023022] Booting paravirtualized kernel on KVM sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 sshClient # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.023025] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns sshClient # [ 0.000000] Hypervisor detected: KVM sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.027671] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.029769] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 sshClient # [ 0.000000] kvm-clock: using sched offset of 505418724 cycles machine # [ 0.029812] kvm-guest: PV spinlocks disabled, single CPU sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns sshClient # [ 0.000005] tsc: Detected 2400.008 MHz processor sshClient # [ 0.000765] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 sshClient # [ 0.000792] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.029813] 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/1k2q12hb0diqqqx41idaivn5zbdggnc9-nixos-system-machine-test/init regInfo=/nix/.ro-store/hi4gv2w3h2gdl4d4ln2vw8n4xryrvw3m-closure-info/registration console=ttyS0,115200n8 console=tty0 sshClient # [ 0.000794] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT sshClient # [ 0.002683] found SMP MP-table at [mem 0x000f5450-0x000f545f] sshClient # [ 0.002695] Using GB pages for direct mapping machine # [ 0.029913] Unknown kernel command line parameters "regInfo=/nix/.ro-store/hi4gv2w3h2gdl4d4ln2vw8n4xryrvw3m-closure-info/registration", will be passed to user space. sshClient # [ 0.002775] RAMDISK: [mem 0x3e2bc000-0x3ffcffff] machine # [ 0.029926] random: crng init done sshClient # [ 0.002782] ACPI: Early table checksum verification disabled machine # [ 0.029927] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes sshClient # [ 0.002786] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.029958] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) sshClient # [ 0.002790] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.030476] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) sshClient # [ 0.002795] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.030504] Fallback order for Node 0: 0 machine # [ 0.030507] Built 1 zonelists, mobility grouping on. Total pages: 262006 sshClient # [ 0.002802] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.030508] Policy zone: DMA32 sshClient # [ 0.002804] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.032741] mem auto-init: stack:all(zero), heap alloc:on, heap free:off sshClient # [ 0.002806] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.035303] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.037652] allocated 2097152 bytes of page_ext sshClient # [ 0.002807] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.048246] ftrace: allocating 48842 entries in 192 pages sshClient # [ 0.002809] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.048252] ftrace: allocated 192 pages with 2 groups machine # [ 0.049237] Dynamic Preempt: lazy sshClient # [ 0.002811] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.049383] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.049384] rcu: RCU event tracing is enabled. sshClient # [ 0.002812] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.049384] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. sshClient # [ 0.002813] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.049386] Trampoline variant of Tasks RCU enabled. sshClient # [ 0.002814] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.049387] Rude variant of Tasks RCU enabled. machine # [ 0.049387] Tracing variant of Tasks RCU enabled. sshClient # [ 0.002814] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.049388] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. sshClient # [ 0.002815] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.049389] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 sshClient # [ 0.002815] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] sshClient # [ 0.002815] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.049448] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.003036] No NUMA configuration found machine # [ 0.049449] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.003037] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] sshClient # [ 0.003039] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.049450] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.005265] Zone ranges: machine # [ 0.053953] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 sshClient # [ 0.005266] DMA [mem 0x0000000000001000-0x0000000000ffffff] sshClient # [ 0.005268] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.054249] rcu: srcu_init: Setting srcu_struct sizes based on contention. sshClient # [ 0.005269] Normal empty sshClient # [ 0.005270] Device empty sshClient # [ 0.005270] Movable zone start for each node machine # [ 0.054255] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns sshClient # [ 0.005271] Early memory node ranges machine # [ 0.054365] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) sshClient # [ 0.005271] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.058093] Console: colour VGA+ 80x25 sshClient # [ 0.005273] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.058097] printk: legacy console [tty0] enabled machine # [ 0.087897] printk: legacy console [ttyS0] enabled sshClient # [ 0.005273] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] sshClient # [ 0.005293] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.195760] ACPI: Core revision 20250807 sshClient # [ 0.005555] On node 0, zone DMA: 97 pages in unavailable ranges sshClient # [ 0.023512] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.196712] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.023969] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.198314] APIC: Switch to symmetric I/O mode setup sshClient # [ 0.023979] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.199288] x2apic enabled sshClient # [ 0.024003] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 sshClient # [ 0.024006] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.200120] APIC: Switched APIC routing to: physical x2apic sshClient # [ 0.024008] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) sshClient # [ 0.024009] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.202068] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 sshClient # [ 0.024010] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) sshClient # [ 0.024010] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.203127] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns sshClient # [ 0.024013] ACPI: Using ACPI (MADT) for SMP configuration information sshClient # [ 0.024014] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.204905] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) sshClient # [ 0.024016] TSC deadline timer available sshClient # [ 0.024020] CPU topo: Max. logical packages: 1 machine # [ 0.205987] x86/cpu: User Mode Instruction Prevention (UMIP) activated sshClient # [ 0.024021] CPU topo: Max. logical dies: 1 sshClient # [ 0.024021] CPU topo: Max. dies per package: 1 machine # [ 0.207014] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 sshClient # [ 0.024025] CPU topo: Max. threads per core: 1 sshClient # [ 0.024026] CPU topo: Num. cores per package: 1 machine # [ 0.207903] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 sshClient # [ 0.024026] CPU topo: Num. threads per package: 1 sshClient # [ 0.024027] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.208906] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto sshClient # [ 0.024044] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() sshClient # [ 0.024076] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.209903] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl sshClient # [ 0.024078] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.210903] Transient Scheduler Attacks: Vulnerable: No microcode sshClient # [ 0.024079] [mem 0x40000000-0xafffffff] available for PCI devices sshClient # [ 0.024081] Booting paravirtualized kernel on KVM machine # [ 0.212683] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.213654] Speculative Return Stack Overflow: Mitigation: Safe RET sshClient # [ 0.024083] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns sshClient # [ 0.028749] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 sshClient # [ 0.031055] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 sshClient # [ 0.031095] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.214690] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.215910] Spectre V2 : Enabling IBPB for BPF machine # [ 0.217475] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier sshClient # [ 0.031096] 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/hmfkww77dc18zp23rffmbyqxc3wjzirh-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/21ghiyfac61zdvqxjc878pcx2bi66ijj-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.218903] active return thunk: srso_alias_return_thunk machine # [ 0.219924] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' sshClient # [ 0.031186] Unknown kernel command line parameters "regInfo=/nix/.ro-store/21ghiyfac61zdvqxjc878pcx2bi66ijj-closure-info/registration", will be passed to user space. sshClient # [ 0.031199] random: crng init done machine # [ 0.220903] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.031199] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.221903] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' sshClient # [ 0.031221] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.222902] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' sshClient # [ 0.031760] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) sshClient # [ 0.031789] Fallback order for Node 0: 0 machine # [ 0.223903] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' sshClient # [ 0.031792] Built 1 zonelists, mobility grouping on. Total pages: 262006 sshClient # [ 0.031793] Policy zone: DMA32 machine # [ 0.224902] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' sshClient # [ 0.033947] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.226773] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' sshClient # [ 0.036395] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 sshClient # [ 0.038632] allocated 2097152 bytes of page_ext machine # [ 0.227903] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 sshClient # [ 0.048500] ftrace: allocating 48842 entries in 192 pages machine # [ 0.228903] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 sshClient # [ 0.048502] ftrace: allocated 192 pages with 2 groups sshClient # [ 0.049310] Dynamic Preempt: lazy machine # [ 0.229902] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 sshClient # [ 0.049437] rcu: Preemptible hierarchical RCU implementation. sshClient # [ 0.049438] rcu: RCU event tracing is enabled. machine # [ 0.230902] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 sshClient # [ 0.049439] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. machine # [ 0.231902] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 sshClient # [ 0.049440] Trampoline variant of Tasks RCU enabled. sshClient # [ 0.049441] Rude variant of Tasks RCU enabled. sshClient # [ 0.049441] Tracing variant of Tasks RCU enabled. machine # [ 0.232903] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. sshClient # [ 0.049442] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. sshClient # [ 0.049443] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 sshClient # [ 0.049457] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.049458] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.049459] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. sshClient # [ 0.053769] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 sshClient # [ 0.054216] rcu: srcu_init: Setting srcu_struct sizes based on contention. sshClient # [ 0.054222] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns sshClient # [ 0.054318] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) sshClient # [ 0.057818] Console: colour VGA+ 80x25 sshClient # [ 0.057821] printk: legacy console [tty0] enabled sshClient # [ 0.087158] printk: legacy console [ttyS0] enabled sshClient # [ 0.193366] ACPI: Core revision 20250807 sshClient # [ 0.194258] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns sshClient # [ 0.195915] APIC: Switch to symmetric I/O mode setup sshClient # [ 0.196921] x2apic enabled sshClient # [ 0.197735] APIC: Switched APIC routing to: physical x2apic sshClient # [ 0.199635] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 sshClient # [ 0.200747] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns sshClient # [ 0.202489] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) sshClient # [ 0.203572] x86/cpu: User Mode Instruction Prevention (UMIP) activated sshClient # [ 0.204611] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 sshClient # [ 0.205487] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 sshClient # [ 0.206490] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto sshClient # [ 0.207487] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl sshClient # [ 0.208487] Transient Scheduler Attacks: Vulnerable: No microcode sshClient # [ 0.209486] Spectre V2 : Mitigation: Enhanced / Automatic IBRS sshClient # [ 0.210486] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.266569] Freeing SMP alternatives memory: 48K machine # [ 0.266906] pid_max: default: 32768 minimum: 301 machine # [ 0.267981] LSM: initializing lsm=capability,landlock,yama,bpf,ima sshClient # [ 0.212282] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.269025] landlock: Up and running. sshClient # [ 0.213505] Spectre V2 : Enabling IBPB for BPF machine # [ 0.269903] Yama: becoming mindful. machine # [ 0.271079] LSM support for eBPF active sshClient # [ 0.215037] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier sshClient # [ 0.215487] active return thunk: srso_alias_return_thunk machine # [ 0.271852] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.216488] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.272923] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) sshClient # [ 0.217486] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' sshClient # [ 0.218486] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.275442] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) sshClient # [ 0.219486] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' sshClient # [ 0.220487] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.276463] Performance Events: Fam17h+ core perfctr, AMD PMU driver. sshClient # [ 0.221486] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.276908] ... version: 2 machine # [ 0.277634] ... bit width: 48 sshClient # [ 0.222486] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.277905] ... generic counters: 6 sshClient # [ 0.224487] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.278700] ... generic bitmap: 000000000000003f machine # [ 0.278917] ... fixed-purpose counters: 0 sshClient # [ 0.225486] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.279664] ... fixed-purpose bitmap: 0000000000000000 sshClient # [ 0.226486] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.279905] ... value mask: 0000ffffffffffff sshClient # [ 0.227486] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.280842] ... max period: 00007fffffffffff sshClient # [ 0.228486] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.281621] ... global_ctrl mask: 000000000000003f machine # [ 0.282032] signal: max sigframe size: 3376 sshClient # [ 0.229486] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.282857] rcu: Hierarchical SRCU implementation. machine # [ 0.283577] rcu: Max phase no-delay instances is 400. machine # [ 0.288492] smp: Bringing up secondary CPUs ... machine # [ 0.288920] smp: Brought up 1 node, 1 CPU machine # [ 0.289676] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) machine # [ 0.290126] Memory: 940324K/1048024K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 100312K reserved, 0K cma-reserved) machine # [ 0.291124] devtmpfs: initialized machine # [ 0.292044] x86/mm: Memory block size: 128MB machine # [ 0.293776] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.294848] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.296002] pinctrl core: initialized pinctrl subsystem machine # [ 0.297158] PM: RTC time: 02:57:02, date: 2026-10-16 machine # [ 0.301072] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.302263] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.302922] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.304053] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.304916] audit: initializing netlink subsys (disabled) machine # [ 0.306191] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.306193] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.306907] thermal_sys: Registered thermal governor 'step_wise' sshClient # [ 0.263983] Freeing SMP alternatives memory: 48K machine # [ 0.307909] audit: type=2000 audit(1792119423.187:1): state=initialized audit_enabled=0 res=1 sshClient # [ 0.264489] pid_max: default: 32768 minimum: 301 machine # [ 0.309907] thermal_sys: Registered thermal governor 'user_space' sshClient # [ 0.265574] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.309909] thermal_sys: Registered thermal governor 'power_allocator' sshClient # [ 0.266602] landlock: Up and running. machine # [ 0.310924] cpuidle: using governor menu sshClient # [ 0.267488] Yama: becoming mindful. sshClient # [ 0.268522] LSM support for eBPF active machine # [ 0.313202] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 sshClient # [ 0.269275] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.314135] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] sshClient # [ 0.270510] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.314909] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.315918] PCI: Using configuration type 1 for base access sshClient # [ 0.273083] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.317127] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. sshClient # [ 0.274052] Performance Events: Fam17h+ core perfctr, AMD PMU driver. sshClient # [ 0.274492] ... version: 2 sshClient # [ 0.275283] ... bit width: 48 sshClient # [ 0.275489] ... generic counters: 6 sshClient # [ 0.276264] ... generic bitmap: 000000000000003f sshClient # [ 0.276502] ... fixed-purpose counters: 0 sshClient # [ 0.277294] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.324179] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages sshClient # [ 0.278256] ... value mask: 0000ffffffffffff sshClient # [ 0.278489] ... max period: 00007fffffffffff machine # [ 0.324906] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page sshClient # [ 0.279451] ... global_ctrl mask: 000000000000003f sshClient # [ 0.280354] signal: max sigframe size: 3376 sshClient # [ 0.281128] rcu: Hierarchical SRCU implementation. sshClient # [ 0.281493] rcu: Max phase no-delay instances is 400. machine # [ 0.329906] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.330906] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page sshClient # [ 0.286930] smp: Bringing up secondary CPUs ... sshClient # [ 0.287503] smp: Brought up 1 node, 1 CPU sshClient # [ 0.288209] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) sshClient # [ 0.288690] Memory: 940340K/1048024K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 100296K reserved, 0K cma-reserved) sshClient # [ 0.289699] devtmpfs: initialized machine # [ 0.339515] ACPI: Added _OSI(Module Device) sshClient # [ 0.290543] x86/mm: Memory block size: 128MB machine # [ 0.339907] ACPI: Added _OSI(Processor Device) machine # [ 0.340714] ACPI: Added _OSI(Processor Aggregator Device) sshClient # [ 0.292284] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.293504] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). sshClient # [ 0.294570] pinctrl core: initialized pinctrl subsystem sshClient # [ 0.295772] PM: RTC time: 02:57:02, date: 2026-10-16 sshClient # [ 0.299168] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.350234] ACPI: 1 ACPI AML tables successfully acquired and loaded sshClient # [ 0.299845] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations sshClient # [ 0.300504] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations sshClient # [ 0.301645] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations sshClient # [ 0.302500] audit: initializing netlink subsys (disabled) machine # [ 0.354332] ACPI: Interpreter enabled machine # [ 0.354921] ACPI: PM: (supports S0 S3 S4 S5) sshClient # [ 0.303678] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.355686] ACPI: Using IOAPIC for interrupt routing sshClient # [ 0.303680] thermal_sys: Registered thermal governor 'bang_bang' sshClient # [ 0.304490] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.355969] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.356906] PCI: Using E820 reservations for host bridge windows sshClient # [ 0.305493] audit: type=2000 audit(1792119423.244:1): state=initialized audit_enabled=0 res=1 sshClient # [ 0.307490] thermal_sys: Registered thermal governor 'user_space' sshClient # [ 0.307491] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.360048] ACPI: Enabled 2 GPEs in block 00 to 3F sshClient # [ 0.308505] cpuidle: using governor menu sshClient # [ 0.310771] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 sshClient # [ 0.311740] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] sshClient # [ 0.312493] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry sshClient # [ 0.313501] PCI: Using configuration type 1 for base access sshClient # [ 0.314668] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.367957] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.368911] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.369984] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.371030] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.372252] PCI host bridge to bus 0000:00 machine # [ 0.372911] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] sshClient # [ 0.321718] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.373906] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] sshClient # [ 0.322490] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.374905] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.375905] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.376906] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.377906] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.327490] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.378906] pci_bus 0000:00: root bus resource [bus 00-ff] sshClient # [ 0.328490] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.379927] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.381353] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint sshClient # [ 0.337139] ACPI: Added _OSI(Module Device) sshClient # [ 0.337491] ACPI: Added _OSI(Processor Device) sshClient # [ 0.338307] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.384039] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.384964] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.385927] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.387240] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.388625] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.347833] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.390916] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.391829] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.392716] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.393834] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] sshClient # [ 0.351947] ACPI: Interpreter enabled sshClient # [ 0.352505] ACPI: PM: (supports S0 S3 S4 S5) sshClient # [ 0.353279] ACPI: Using IOAPIC for interrupt routing machine # [ 0.396016] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.397927] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] sshClient # [ 0.356551] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.398813] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] sshClient # [ 0.357498] PCI: Using E820 reservations for host bridge windows machine # [ 0.399696] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] sshClient # [ 0.358579] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.401353] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.403914] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.404842] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.405680] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] sshClient # [ 0.366013] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) sshClient # [ 0.366494] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.407317] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint sshClient # [ 0.367575] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] sshClient # [ 0.368613] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.408925] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] sshClient # [ 0.369861] PCI host bridge to bus 0000:00 machine # [ 0.409808] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] sshClient # [ 0.370494] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] sshClient # [ 0.371489] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.410666] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] sshClient # [ 0.372489] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.411912] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] sshClient # [ 0.373489] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.413477] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint sshClient # [ 0.374489] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.375489] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.414789] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] sshClient # [ 0.376489] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.415723] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] sshClient # [ 0.377460] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.417381] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.378941] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.418917] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.419929] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.421543] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.422787] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] sshClient # [ 0.381624] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.423705] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] sshClient # [ 0.382547] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] sshClient # [ 0.383488] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.425360] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint sshClient # [ 0.384782] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.426899] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] sshClient # [ 0.386187] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.427940] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.429439] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint sshClient # [ 0.388531] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] sshClient # [ 0.389339] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.430944] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] sshClient # [ 0.390226] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.431828] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] sshClient # [ 0.390500] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.432709] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] sshClient # [ 0.392049] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.434365] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint sshClient # [ 0.393508] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.435912] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] sshClient # [ 0.394354] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.436811] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] sshClient # [ 0.395246] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.437736] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] sshClient # [ 0.396050] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.439430] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.440573] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.441121] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.398718] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] sshClient # [ 0.399495] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.442730] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] sshClient # [ 0.400511] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.443820] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint sshClient # [ 0.402074] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.445447] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] sshClient # [ 0.403497] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] sshClient # [ 0.404340] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] sshClient # [ 0.405224] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] sshClient # [ 0.405502] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] sshClient # [ 0.407056] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint sshClient # [ 0.408311] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] sshClient # [ 0.409203] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] sshClient # [ 0.410059] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.446131] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint sshClient # [ 0.411535] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.448418] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] sshClient # [ 0.412466] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.449198] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.450190] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO sshClient # [ 0.414230] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.451148] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint sshClient # [ 0.416266] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] sshClient # [ 0.416511] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.452807] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.453594] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] sshClient # [ 0.418034] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.454218] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint sshClient # [ 0.419489] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.455481] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] sshClient # [ 0.420443] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] sshClient # [ 0.422345] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.459370] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 sshClient # [ 0.424513] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] sshClient # [ 0.425362] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.460021] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 sshClient # [ 0.426227] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.461008] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.462012] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 sshClient # [ 0.427076] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.463007] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.464003] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.465019] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 sshClient # [ 0.428531] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.466001] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 sshClient # [ 0.429495] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] sshClient # [ 0.430420] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.466947] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.467923] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.431867] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.468922] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.469917] ACPI: PCI: Interrupt link GSID configured for IRQ 19 sshClient # [ 0.433059] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.470921] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 sshClient # [ 0.433690] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.471918] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.472897] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 sshClient # [ 0.435043] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.473890] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.435676] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.475718] iommu: Default domain type: Translated sshClient # [ 0.437505] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.476556] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.477163] ACPI: bus type USB registered machine # [ 0.477937] usbcore: registered new interface driver usbfs machine # [ 0.478887] usbcore: registered new interface driver hub machine # [ 0.479606] usbcore: registered new device driver usb machine # [ 0.480854] NetLabel: Initializing machine # [ 0.481375] NetLabel: domain hash size = 128 machine # [ 0.481905] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.482852] NetLabel: unlabeled traffic allowed by default machine # [ 0.483605] PCI: Using ACPI for IRQ routing sshClient # [ 0.438590] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint sshClient # [ 0.440962] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] sshClient # [ 0.441772] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint sshClient # [ 0.442768] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO sshClient # [ 0.443773] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint sshClient # [ 0.445517] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] sshClient # [ 0.446395] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] sshClient # [ 0.447534] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint sshClient # [ 0.449033] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] sshClient # [ 0.452556] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 sshClient # [ 0.453594] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 sshClient # [ 0.454589] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 sshClient # [ 0.455587] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 sshClient # [ 0.456585] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 sshClient # [ 0.457583] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 sshClient # [ 0.458587] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 sshClient # [ 0.459583] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 sshClient # [ 0.460524] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 sshClient # [ 0.461444] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 sshClient # [ 0.462205] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 sshClient # [ 0.462514] ACPI: PCI: Interrupt link GSID configured for IRQ 19 sshClient # [ 0.463499] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 sshClient # [ 0.464442] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 sshClient # [ 0.465213] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 sshClient # [ 0.465503] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 sshClient # [ 0.467567] iommu: Default domain type: Translated sshClient # [ 0.468343] iommu: DMA domain TLB invalidation policy: lazy mode sshClient # [ 0.469529] ACPI: bus type USB registered sshClient # [ 0.470261] usbcore: registered new interface driver usbfs sshClient # [ 0.470505] usbcore: registered new interface driver hub sshClient # [ 0.471361] usbcore: registered new device driver usb sshClient # [ 0.473059] NetLabel: Initializing sshClient # [ 0.473490] NetLabel: domain hash size = 128 machine # [ 0.527878] pci 0000:00:01.0: vgaarb: setting as boot VGA device sshClient # [ 0.474208] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.527901] pci 0000:00:01.0: vgaarb: bridge control possible sshClient # [ 0.474531] NetLabel: unlabeled traffic allowed by default sshClient # [ 0.475433] PCI: Using ACPI for IRQ routing machine # [ 0.527901] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.527910] vgaarb: loaded machine # [ 0.528695] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.529575] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.532992] clocksource: Switched to clocksource kvm-clock machine # [ 0.536730] VFS: Disk quotas dquot_6.6.0 machine # [ 0.537453] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.538878] pnp: PnP ACPI init machine # [ 0.539763] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.540775] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.542367] pnp: PnP ACPI: found 5 devices machine # [ 0.549919] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.551391] clocksource: Switched to clocksource acpi_pm machine # [ 0.552443] NET: Registered PF_INET protocol family machine # [ 0.553495] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) sshClient # [ 0.519556] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.570314] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.520485] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.571903] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.520485] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none sshClient # [ 0.520493] vgaarb: loaded machine # [ 0.573268] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.521202] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 sshClient # [ 0.521490] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.574674] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.575942] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.577092] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.578411] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.524577] clocksource: Switched to clocksource kvm-clock machine # [ 0.579585] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.580853] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.581861] NET: Registered PF_XDP protocol family sshClient # [ 0.528123] VFS: Disk quotas dquot_6.6.0 machine # [ 0.582742] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] sshClient # [ 0.528815] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.583780] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] sshClient # [ 0.530118] pnp: PnP ACPI init machine # [ 0.584839] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] sshClient # [ 0.530885] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.585990] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] sshClient # [ 0.531786] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.587121] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.533297] pnp: PnP ACPI: found 5 devices machine # [ 0.588286] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.590067] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.592709] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.594696] ACPI: \_SB_.GSIC: Enabled at IRQ 18 sshClient # [ 0.540781] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.596609] ACPI: \_SB_.GSID: Enabled at IRQ 19 sshClient # [ 0.542186] clocksource: Switched to clocksource acpi_pm sshClient # [ 0.543143] NET: Registered PF_INET protocol family machine # [ 0.598275] PCI: CLS 0 bytes, default 64 sshClient # [ 0.544157] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.599171] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.600959] Trying to unpack rootfs image as initramfs... sshClient # [ 0.561032] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) sshClient # [ 0.562616] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) sshClient # [ 0.563862] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) sshClient # [ 0.565152] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) sshClient # [ 0.566370] TCP: Hash tables configured (established 8192 bind 8192) sshClient # [ 0.567442] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) sshClient # [ 0.568716] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.569798] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) sshClient # [ 0.570916] NET: Registered PF_UNIX/PF_LOCAL protocol family sshClient # [ 0.571825] NET: Registered PF_XDP protocol family sshClient # [ 0.572667] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] sshClient # [ 0.573651] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] sshClient # [ 0.574641] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] sshClient # [ 0.575721] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] sshClient # [ 0.576788] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] sshClient # [ 0.577837] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] sshClient # [ 0.579565] ACPI: \_SB_.GSIA: Enabled at IRQ 16 sshClient # [ 0.582240] ACPI: \_SB_.GSIB: Enabled at IRQ 17 sshClient # [ 0.584190] ACPI: \_SB_.GSIC: Enabled at IRQ 18 sshClient # [ 0.586109] ACPI: \_SB_.GSID: Enabled at IRQ 19 sshClient # [ 0.587730] PCI: CLS 0 bytes, default 64 sshClient # [ 0.588599] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns sshClient # [ 0.590249] Trying to unpack rootfs image as initramfs... machine # [ 0.647093] Initialise system trusted keyrings machine # [ 0.649722] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.669444] Key type asymmetric registered machine # [ 0.674689] Asymmetric key parser 'x509' registered machine # [ 0.675639] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.678794] io scheduler mq-deadline registered machine # [ 0.679613] io scheduler kyber registered machine # [ 0.683247] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.684602] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.689850] Linux agpgart interface v0.103 sshClient # [ 0.635767] Initialise system trusted keyrings machine # [ 0.690711] ACPI: bus type drm_connector registered sshClient # [ 0.639331] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.694124] usbcore: registered new interface driver usbserial_generic machine # [ 0.695305] usbserial: USB Serial support registered for generic machine # [ 0.698677] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.698677] Please enable it if your BIOS has the CPPC option. machine # [ 0.701024] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.703810] drop_monitor: Initializing network drop monitor service machine # [ 0.705061] NET: Registered PF_INET6 protocol family machine # [ 0.710206] Segment Routing with IPv6 machine # [ 0.713705] In-situ OAM (IOAM) with IPv6 machine # [ 0.714922] IPI shorthand broadcast: enabled sshClient # [ 0.660627] Key type asymmetric registered sshClient # [ 0.663297] Asymmetric key parser 'x509' registered sshClient # [ 0.664241] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) sshClient # [ 0.668400] io scheduler mq-deadline registered sshClient # [ 0.669210] io scheduler kyber registered machine # [ 0.723327] sched_clock: Marking stable (577015383, 145647155)->(799538851, -76876313) machine # [ 0.726842] registered taskstats version 1 sshClient # [ 0.672451] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.727893] Loading compiled-in X.509 certificates sshClient # [ 0.673775] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A sshClient # [ 0.679091] Linux agpgart interface v0.103 sshClient # [ 0.679878] ACPI: bus type drm_connector registered sshClient # [ 0.684364] usbcore: registered new interface driver usbserial_generic sshClient # [ 0.685478] usbserial: USB Serial support registered for generic sshClient # [ 0.688299] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. sshClient # [ 0.688299] Please enable it if your BIOS has the CPPC option. sshClient # [ 0.690793] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.746893] Demotion targets for Node 0: null sshClient # [ 0.694465] drop_monitor: Initializing network drop monitor service machine # [ 0.749713] Key type .fscrypt registered sshClient # [ 0.695685] NET: Registered PF_INET6 protocol family machine # [ 0.750425] Key type fscrypt-provisioning registered machine # [ 0.751390] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.699751] Segment Routing with IPv6 machine # [ 0.755673] ima: Allocated hash algorithm: sha1 machine # [ 0.756498] ima: No architecture policies found sshClient # [ 0.702325] In-situ OAM (IOAM) with IPv6 machine # [ 0.757449] PM: Magic number: 14:877:965 sshClient # [ 0.703419] IPI shorthand broadcast: enabled machine # [ 0.761235] RAS: Correctable Errors collector initialized. sshClient # [ 0.711751] sched_clock: Marking stable (568013591, 143263724)->(786327021, -75049706) machine # [ 0.770065] clk: Disabling unused clocks sshClient # [ 0.717457] registered taskstats version 1 machine # [ 0.772686] PM: genpd: Disabling unused power domains sshClient # [ 0.718456] Loading compiled-in X.509 certificates sshClient # [ 0.734827] Demotion targets for Node 0: null sshClient # [ 0.738379] Key type .fscrypt registered sshClient # [ 0.739088] Key type fscrypt-provisioning registered sshClient # [ 0.740037] ima: No TPM chip found, activating TPM-bypass! sshClient # [ 0.742304] ima: Allocated hash algorithm: sha1 sshClient # [ 0.743165] ima: No architecture policies found sshClient # [ 0.745294] PM: Magic number: 14:877:965 sshClient # [ 0.746947] RAS: Correctable Errors collector initialized. sshClient # [ 0.758022] clk: Disabling unused clocks sshClient # [ 0.760296] PM: genpd: Disabling unused power domains machine # [ 0.949110] Freeing initrd memory: 29792K machine # [ 0.952426] Freeing unused decrypted memory: 2028K machine # [ 0.955164] Freeing unused kernel image (initmem) memory: 3660K machine # [ 0.956264] Write protecting the kernel read-only data: 32768k machine # [ 0.957583] Freeing unused kernel image (text/rodata gap) memory: 296K machine # [ 0.959123] Freeing unused kernel image (rodata/data gap) memory: 684K sshClient # [ 0.923692] Freeing initrd memory: 29776K sshClient # [ 0.926867] Freeing unused decrypted memory: 2028K sshClient # [ 0.929516] Freeing unused kernel image (initmem) memory: 3660K sshClient # [ 0.930629] Write protecting the kernel read-only data: 32768k sshClient # [ 0.931960] Freeing unused kernel image (text/rodata gap) memory: 296K sshClient # [ 0.933533] Freeing unused kernel image (rodata/data gap) memory: 684K machine # [ 1.010123] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 1.011289] Run /init as init process machine # [ 1.022394] systemd[1]: Inserted module 'autofs4' sshClient # [ 0.984770] x86/mm: Checked W+X mappings: passed, no W+X pages found. sshClient # [ 0.985914] Run /init as init process machine # [ 1.042772] fuse: init (API version 7.45) machine # [ 1.050132] ACPI: \_SB_.GSIG: Enabled at IRQ 22 sshClient # [ 0.996517] systemd[1]: Inserted module 'autofs4' machine # [ 1.052808] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.056525] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.058836] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.064220] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.065760] virtiofs virtio5: virtio_fs_setup_dax: No cache capability sshClient # [ 1.016921] fuse: init (API version 7.45) machine # [ 1.074799] virtiofs virtio6: discovered new tag: shared machine # [ 1.076464] virtiofs virtio6: virtio_fs_setup_dax: No cache capability sshClient # [ 1.024735] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.081196] virtiofs virtio7: discovered new tag: xchg sshClient # [ 1.027380] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.082794] virtiofs virtio7: virtio_fs_setup_dax: No cache capability sshClient # [ 1.031590] ACPI: \_SB_.GSIE: Enabled at IRQ 20 sshClient # [ 1.033818] ACPI: \_SB_.GSIF: Enabled at IRQ 21 sshClient # [ 1.039181] virtiofs virtio5: discovered new tag: nix-store sshClient # [ 1.040812] virtiofs virtio5: virtio_fs_setup_dax: No cache capability sshClient # [ 1.048156] virtiofs virtio6: discovered new tag: shared sshClient # [ 1.049671] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.104993] systemd[1]: Successfully made /usr/ read-only. sshClient # [ 1.052899] virtiofs virtio7: discovered new tag: xchg sshClient # [ 1.054343] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.106825] systemd[1]: systemd 263-78a159b 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.112012] systemd[1]: Detected virtualization kvm. machine # [ 1.112882] systemd[1]: Detected architecture x86-64. machine # [ 1.113756] systemd[1]: Running in initrd. machine # [ 1.114737] systemd[1]: Initializing machine ID from random generator. machine # [ 1.115891] systemd[1]: Hostname set to . sshClient # [ 1.077052] systemd[1]: Successfully made /usr/ read-only. sshClient # [ 1.078808] systemd[1]: systemd 263-78a159b 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.084445] systemd[1]: Detected virtualization kvm. sshClient # [ 1.085377] systemd[1]: Detected architecture x86-64. sshClient # [ 1.086319] systemd[1]: Running in initrd. sshClient # [ 1.087319] systemd[1]: Initializing machine ID from random generator. sshClient # [ 1.088554] systemd[1]: Hostname set to . machine # [ 1.191799] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 1.159221] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.228149] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.231973] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.233318] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.234801] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.235966] systemd[1]: Reached target Path Units. machine # [ 1.236885] systemd[1]: Reached target Slice Units. machine # [ 1.237828] systemd[1]: Reached target Swaps. machine # [ 1.238692] systemd[1]: Reached target Timer Units. machine # [ 1.239720] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.241022] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.242233] systemd[1]: Listening on Journal Sockets. machine # [ 1.243264] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.244232] systemd[1]: Reached target Socket Units. machine # [ 1.246048] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 1.194735] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.250735] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 1.198542] systemd[1]: Created slice Slice /system/modprobe. sshClient # [ 1.199816] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 1.201291] systemd[1]: Expecting device /dev/disk/by-label/nixos... sshClient # [ 1.202433] systemd[1]: Reached target Path Units. sshClient # [ 1.203377] systemd[1]: Reached target Slice Units. sshClient # [ 1.204308] systemd[1]: Reached target Swaps. sshClient # [ 1.205154] systemd[1]: Reached target Timer Units. machine # [ 1.260781] systemd[1]: Starting Journal Service... sshClient # [ 1.206180] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 1.207476] systemd[1]: Listening on Journal Socket (/dev/log). sshClient # [ 1.208690] systemd[1]: Listening on Journal Sockets. sshClient # [ 1.209706] systemd[1]: Listening on udev Kernel Socket. sshClient # [ 1.210675] systemd[1]: Reached target Socket Units. sshClient # [ 1.212446] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 1.216353] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 1.224821] systemd[1]: Starting Journal Service... machine # [ 1.270758] systemd[1]: Starting Load Kernel Modules... machine # [ 1.285779] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.292857] systemd[1]: Starting Coldplug All udev Devices... sshClient # [ 1.234392] systemd[1]: Starting Load Kernel Modules... sshClient # [ 1.249571] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.306010] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.311299] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 1.257051] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.320092] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.323508] systemd-journald[65]: Collecting audit messages is disabled. sshClient # [ 1.270354] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.326134] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config sshClient # [ 1.275903] systemd[1]: modprobe@configfs.service: Deactivated successfully. sshClient # [ 1.283675] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.337737] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 1.285604] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.340150] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. sshClient # [ 1.289746] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.351232] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev sshClient # [ 1.299346] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 1.304053] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. sshClient # [ 1.314876] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.375211] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.383860] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 1.339816] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.395181] systemd[1]: Finished Load Kernel Modules. sshClient # [ 1.347462] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.403860] systemd[1]: Starting Apply Kernel Variables... sshClient # [ 1.359355] systemd[1]: Finished Load Kernel Modules. sshClient # [ 1.367634] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.423236] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.429858] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.434751] systemd[1]: Reached target Local File Systems. sshClient # [ 1.386843] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.441865] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.297960] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.301048] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.302124] systemd-modules-load[66]: Inserted module 'virtio_gpu' sshClient # [ 1.394560] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.452957] systemd[1]: Started Journal Service. sshClient # [ 1.399347] systemd[1]: Reached target Local File Systems. machine # [ 1.314190] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 1.259616] systemd-modules-load[66]: Inserted module 'dm_mod'[ 1.406486] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # sshClient # [ 1.264517] systemd-modules-load[66]: Inserted module 'virtio_balloon' sshClient # [ 1.265635] systemd-modules-load[66]: Inserted module 'virtio_gpu' sshClient # [ 1.415527] systemd[1]: Started Journal Service. machine # [ 1.325434] systemd[1]: Starting Create System Files and Directories... sshClient # [ 1.277189] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 1.288291] systemd[1]: Starting Create System Files and Directories... machine # [ 1.355487] systemd[1]: Finished Create System Files and Directories. machine # [ 1.361433] systemd-udevd[73]: Using default interface naming scheme 'v261'. sshClient # [ 1.315092] systemd[1]: Finished Create System Files and Directories. sshClient # [ 1.328340] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.385069] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 1.351969] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.442947] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.443831] systemd[1]: Reached target System Initialization. machine # [ 1.444689] systemd[1]: Reached target Basic System. sshClient # [ 1.406821] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 1.409305] systemd[1]: Reached target System Initialization. sshClient # [ 1.410501] systemd[1]: Reached target Basic System. machine # [ 1.734856] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.740079] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.748306] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.752426] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.753816] serio: i8042 AUX port at 0x60,0x64 irq 12 sshClient # [ 1.701680] virtio_blk virtio2: 1/0/0 default/read/poll queues sshClient # [ 1.707144] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.763383] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.764306] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 1.766061] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 sshClient # [ 1.711384] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 sshClient # [ 1.717373] serio: i8042 KBD port at 0x60,0x64 irq 1 sshClient # [ 1.718119] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.772687] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.773859] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.776255] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.778606] usb usb1: Product: EHCI Host Controller sshClient # [ 1.724650] ehci-pci 0000:00:1d.7: EHCI Host Controller sshClient # [ 1.725387] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 sshClient # [ 1.727112] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.781668] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd machine # [ 1.782427] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.783381] hub 1-0:1.0: USB hub found machine # [ 1.785678] hub 1-0:1.0: 6 ports detected sshClient # [ 1.734302] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 sshClient # [ 1.735249] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.790289] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.791028] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 sshClient # [ 1.738035] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.739508] usb usb1: Product: EHCI Host Controller sshClient # [ 1.740191] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd sshClient # [ 1.742091] usb usb1: SerialNumber: 0000:00:1d.7 sshClient # [ 1.743727] hub 1-0:1.0: USB hub found sshClient # [ 1.746284] hub 1-0:1.0: 6 ports detected sshClient # [ 1.748422] uhci_hcd 0000:00:1d.0: UHCI Host Controller sshClient # [ 1.749144] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.804742] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.805585] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.815276] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.816401] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.819087] SCSI subsystem initialized sshClient # [ 1.766900] uhci_hcd 0000:00:1d.0: detected 2 ports sshClient # [ 1.777254] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.836381] usb usb2: Product: UHCI Host Controller sshClient # [ 1.785022] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.786181] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.841743] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.843455] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.844461] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.704198] systemd[1]: Starting Virtual Console Setup... sshClient # [ 1.655499] systemd[1]: Starting Virtual Console Setup... machine # [ 1.854119] hub 2-0:1.0: USB hub found machine # [ 1.855615] hub 2-0:1.0: 2 ports detected sshClient # [ 1.801363] usb usb2: Product: UHCI Host Controller sshClient # [ 1.802113] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.722247] (udev-worker)[83]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 1.819714] SCSI subsystem initialized sshClient # [ 1.823290] usb usb2: SerialNumber: 0000:00:1d.0 sshClient # [ 1.682530] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 1.684971] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.737106] (udev-worker)[83]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.741848] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. sshClient # [ 1.833278] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.891205] uhci_hcd 0000:00:1d.1: UHCI Host Controller sshClient # [ 1.693516] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.891966] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 sshClient # [ 1.697480] systemd[1]: Finished Virtual Console Setup. sshClient # [ 1.842009] hub 2-0:1.0: USB hub found sshClient # [ 1.842983] hub 2-0:1.0: 2 ports detected machine # [ 1.752761] systemd[1]: Finished Virtual Console Setup. machine # [ 1.909704] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.910468] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 sshClient # [ 1.856121] uhci_hcd 0000:00:1d.1: UHCI Host Controller sshClient # [ 1.857031] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.914757] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.916180] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.772148] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.775067] systemd[1]: Reached target Initrd Root Device. sshClient # [ 1.723269] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.775809] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... sshClient # [ 1.726758] systemd[1]: Reached target Initrd Root Device. machine # [ 1.926716] usb usb3: Product: UHCI Host Controller machine # [ 1.927487] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.928370] usb usb3: SerialNumber: 0000:00:1d.1 sshClient # [ 1.731064] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... sshClient # [ 1.875363] uhci_hcd 0000:00:1d.1: detected 2 ports sshClient # [ 1.876126] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 sshClient # [ 1.878447] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.935843] hub 3-0:1.0: USB hub found machine # [ 1.937792] hub 3-0:1.0: 2 ports detected sshClient # [ 1.887296] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.942805] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 1.889292] usb usb3: Product: UHCI Host Controller machine # [ 1.943544] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 sshClient # [ 1.890011] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.946732] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.947530] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 sshClient # [ 1.894322] usb usb3: SerialNumber: 0000:00:1d.1 sshClient # [ 1.896693] hub 3-0:1.0: USB hub found machine # [ 1.950886] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 sshClient # [ 1.897815] hub 3-0:1.0: 2 ports detected machine # [ 1.953710] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.958668] usb usb4: Product: UHCI Host Controller machine # [ 1.960706] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.961446] usb usb4: SerialNumber: 0000:00:1d.2 sshClient # [ 1.908296] uhci_hcd 0000:00:1d.2: UHCI Host Controller sshClient # [ 1.909131] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.966016] hub 4-0:1.0: USB hub found machine # [ 1.821907] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks sshClient # [ 1.915026] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.970712] hub 4-0:1.0: 2 ports detected sshClient # [ 1.916493] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 sshClient # [ 1.774735] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks sshClient # [ 1.920421] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.829820] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. sshClient # [ 1.784492] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. sshClient # [ 1.929393] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 sshClient # [ 1.932473] usb usb4: Product: UHCI Host Controller sshClient # [ 1.933253] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd sshClient # [ 1.934249] usb usb4: SerialNumber: 0000:00:1d.2 sshClient # [ 1.937050] hub 4-0:1.0: USB hub found sshClient # [ 1.939348] hub 4-0:1.0: 2 ports detected machine # [ 1.993312] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.001360] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.003073] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.006794] scsi host0: ahci machine # [ 2.008634] scsi host1: ahci machine # [ 2.010377] scsi host2: ahci sshClient # [ 1.957682] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.013244] scsi host3: ahci machine # [ 2.015251] scsi host4: ahci machine # [ 2.017412] scsi host5: ahci machine # [ 2.019835] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 sshClient # [ 1.967828] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.022684] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 1.970294] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.024687] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.025956] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.027118] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.028497] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 sshClient # [ 1.975897] scsi host0: ahci machine # [ 2.029787] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 sshClient # [ 1.977125] scsi host1: ahci sshClient # [ 1.978702] scsi host2: ahci sshClient # [ 1.980206] scsi host3: ahci sshClient # [ 1.981643] scsi host4: ahci sshClient # [ 1.983056] scsi host5: ahci sshClient # [ 1.983586] usb 1-1: new high-speed USB device number 2 using ehci-pci sshClient # [ 1.985125] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 sshClient # [ 1.986790] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 sshClient # [ 1.987951] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 sshClient # [ 1.989134] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 sshClient # [ 1.990323] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 sshClient # [ 1.991615] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.154119] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.157086] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.160268] usb 1-1: Product: QEMU USB Tablet machine # [ 2.162160] usb 1-1: Manufacturer: QEMU machine # [ 2.163890] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 sshClient # [ 2.114546] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 sshClient # [ 2.115769] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 sshClient # [ 2.117070] usb 1-1: Product: QEMU USB Tablet sshClient # [ 2.117779] usb 1-1: Manufacturer: QEMU sshClient # [ 2.118464] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 sshClient # [ 2.131980] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.199857] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.161350] systemd[1]: Mounting /sysroot... sshClient # [ 2.122085] systemd[1]: Mounting /sysroot... machine # [ 2.342820] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.344695] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.346492] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.348406] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.352684] ata3.00: applying bridge limits machine # [ 2.354264] ata3.00: configured for UDMA/100 machine # [ 2.357909] ata4: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.302903] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.360082] ata6: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.305975] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.362131] ata1: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.308448] ata3.00: applying bridge limits sshClient # [ 2.310504] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.364808] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 sshClient # [ 2.312638] ata2: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.314985] ata4: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.317321] ata6: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.319237] ata1: SATA link down (SStatus 0 SControl 300) sshClient # [ 2.321007] ata3.00: configured for UDMA/100 sshClient # [ 2.322902] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.423893] usbcore: registered new interface driver usbhid machine # [ 2.424811] usbhid: USB HID core driver machine # [ 2.433926] 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.384390] usbcore: registered new interface driver usbhid sshClient # [ 2.385334] usbhid: USB HID core driver machine # [ 2.438784] 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.442773] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray sshClient # [ 2.398166] 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.456760] cdrom: Uniform CD-ROM driver Revision: 3.20 sshClient # [ 2.404415] 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.409365] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray sshClient # [ 2.424291] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.487855] EXT4-fs (vda): mounted filesystem 0366f8ce-a63c-499c-9a0c-53641e19b580 r/w with ordered data mode. Quota mode: none. machine # [ 2.345968] systemd[1]: Mounted /sysroot. machine # [ 2.347382] systemd[1]: Reached target Initrd Root File System. machine # [ 2.349328] systemd[1]: Starting Mountpoints Configured in the Real Root... sshClient # [ 2.448087] EXT4-fs (vda): mounted filesystem beb9b0a7-6b97-4823-a932-441fc96bb4ea r/w with ordered data mode. Quota mode: none. sshClient # [ 2.311107] systemd[1]: Mounted /sysroot. sshClient # [ 2.312591] systemd[1]: Reached target Initrd Root File System. machine # [ 2.364847] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload. sshClient # [ 2.314569] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.367632] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.369138] systemd[1]: Reloading... sshClient # [ 2.330866] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload. sshClient # [ 2.332511] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)... sshClient # [ 2.335877] systemd[1]: Reloading... machine # [ 2.436895] systemd[1]: Reloading finished in 66 ms. machine # [ 2.444952] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace... machine # [ 2.449174] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace... machine # [ 2.452497] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.453870] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.454942] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. sshClient # [ 2.404861] systemd[1]: Reloading finished in 69 ms. sshClient # [ 2.412879] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace... sshClient # [ 2.416147] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace... sshClient # [ 2.420565] systemd[1]: initrd-parse-etc.service: Deactivated successfully. sshClient # [ 2.421913] systemd[1]: Finished Mountpoints Configured in the Real Root. sshClient # [ 2.422970] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.163179] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.170184] systemd[1]: Mounting /sysroot/nix/.rw-store... sshClient # [ 3.123091] systemd[1]: Mounting /sysroot/nix/.ro-store... sshClient # [ 3.126080] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.179165] systemd[1]: Mounting /sysroot/run... sshClient # [ 3.130134] systemd[1]: Mounting /sysroot/run... sshClient # [ 3.136138] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.188212] systemd[1]: Mounting /sysroot/tmp/shared... sshClient # [ 3.140572] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.198284] systemd[1]: Mounting /sysroot/tmp/xchg... sshClient # [ 3.162037] systemd[1]: Mounted /sysroot/nix/.ro-store. sshClient # [ 3.168112] systemd[1]: Mounted /sysroot/nix/.rw-store. sshClient # [ 3.169158] systemd[1]: Mounted /sysroot/run. sshClient # [ 3.170828] systemd[1]: Mounted /sysroot/tmp/shared. sshClient # [ 3.175229] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 3.177740] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.233333] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.235703] systemd[1]: Mounted /sysroot/nix/.ro-store. sshClient # [ 3.187849] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 3.188881] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.241625] systemd[1]: Mounted /sysroot/run. machine # [ 3.245158] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.247231] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.250811] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.260809] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.262346] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.162659] systemd[1]: Mounting /sysroot/nix/store... sshClient # [ 4.122601] systemd[1]: Mounting /sysroot/nix/store... sshClient # [ 4.144950] systemd[1]: Mounted /sysroot/nix/store. sshClient # [ 4.146323] systemd[1]: Reached target Initrd File Systems. sshClient # [ 4.147932] systemd[1]: Starting Find NixOS closure... sshClient # [ 4.150751] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.210873] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.212628] systemd[1]: Reached target Initrd File Systems. machine # [ 4.215078] systemd[1]: Starting Find NixOS closure... machine # [ 4.218138] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... sshClient # [ 4.171964] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. sshClient # [ 4.173118] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. sshClient # [ 4.178881] systemd[1]: Finished Find NixOS closure. sshClient # [ 4.179974] systemd[1]: Reached target Initrd Default Target. sshClient # [ 4.181783] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.237148] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.238929] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.246182] systemd[1]: Finished Find NixOS closure. sshClient # [ 4.195474] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.247532] systemd[1]: Reached target Initrd Default Target. sshClient # [ 4.196604] systemd[1]: Stopped target Basic System. machine # [ 4.249272] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... sshClient # [ 4.199227] systemd[1]: Stopped target Initrd Root Device. sshClient # [ 4.200041] systemd[1]: Stopped target Path Units. sshClient # [ 4.200732] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. sshClient # [ 4.201844] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. sshClient # [ 4.202919] systemd[1]: Stopped target Slice Units. sshClient # [ 4.203588] systemd[1]: Stopped target Socket Units. sshClient # [ 4.204320] systemd[1]: Stopped target System Initialization. sshClient # [ 4.205147] systemd[1]: Stopped target Swaps. sshClient # [ 4.205791] systemd[1]: Stopped target Timer Units. sshClient # [ 4.206517] systemd[1]: dbus.socket: Deactivated successfully. sshClient # [ 4.207381] systemd[1]: Closed D-Bus System Message Bus Socket. sshClient # [ 4.208209] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. sshClient # [ 4.209565] systemd[1]: Stopped Find NixOS closure. sshClient # [ 4.210656] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.263050] systemd[1]: Stopped target Initrd Default Target. sshClient # [ 4.211611] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.264338] systemd[1]: Stopped target Basic System. machine # [ 4.265287] systemd[1]: Stopped target Initrd Root Device. sshClient # [ 4.213429] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.266253] systemd[1]: Stopped target Path Units. sshClient # [ 4.214412] systemd[1]: systemd-modules-load.service: Deactivated successfully. sshClient # [ 4.215585] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.268061] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. sshClient # [ 4.216520] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.269101] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.270156] systemd[1]: Stopped target Slice Units. sshClient # [ 4.218207] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.270834] systemd[1]: Stopped target Socket Units. machine # [ 4.271644] systemd[1]: Stopped target System Initialization. sshClient # [ 4.219505] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.272460] systemd[1]: Stopped target Swaps. sshClient # [ 4.220667] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.273182] systemd[1]: Stopped target Timer Units. sshClient # [ 4.221785] systemd[1]: Stopped target Local File Systems. machine # [ 4.274217] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.275230] systemd[1]: Closed D-Bus System Message Bus Socket. sshClient # [ 4.223311] systemd[1]: Stopped target Preparation for Local File Systems. sshClient # [ 4.224384] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.276856] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. sshClient # [ 4.225462] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.277883] systemd[1]: Stopped Find NixOS closure. machine # [ 4.279099] systemd[1]: Starting rw-sysroot-nix-store.service... sshClient # [ 4.227106] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.279947] systemd[1]: systemd-sysctl.service: Deactivated successfully. sshClient # [ 4.228137] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.281316] systemd[1]: Stopped Apply Kernel Variables. sshClient # [ 4.229599] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.282339] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.284294] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.285260] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.286547] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.288115] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.289183] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.290061] systemd[1]: Stopped target Local File Systems. sshClient # [ 4.239492] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.292109] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.293104] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. sshClient # [ 4.242078] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.294315] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.296533] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.297567] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 4.245872] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.298583] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 4.247901] systemd[1]: Stopped Rule-based Manager for Device Events and Files. sshClient # [ 4.249503] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 4.250935] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.305705] systemd[1]: initrd-cleanup.service: Deactivated successfully. sshClient # [ 4.255166] systemd[1]: Starting Cleanup udev Database... sshClient # [ 4.256128] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.309170] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. sshClient # [ 4.257699] systemd[1]: Stopped Create Static Device Nodes in /dev. sshClient # [ 4.258563] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. sshClient # [ 4.260128] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. sshClient # [ 4.261120] systemd[1]: kmod-static-nodes.service: Deactivated successfully. sshClient # [ 4.262045] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.315127] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.318097] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.320135] systemd[1]: Starting Cleanup udev Database... machine # [ 4.320930] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.323059] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.323912] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.324984] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.326051] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.327036] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.327843] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. sshClient # [ 4.276172] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. sshClient # [ 4.277432] systemd[1]: Finished Cleanup udev Database. machine # [ 4.330116] systemd[1]: Finished rw-sysroot-nix-store.service. sshClient # [ 4.278605] systemd[1]: Reached target Switch Root. sshClient # [ 4.280125] systemd[1]: Starting NixOS Activation... machine # [ 4.345022] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.346591] systemd[1]: Finished Cleanup udev Database. machine # [ 4.348272] systemd[1]: Reached target Switch Root. machine # [ 4.349477] systemd[1]: Starting NixOS Activation... sshClient # [ 4.337730] initrd-nixos-activation-start[189]: booting system configuration /nix/store/hmfkww77dc18zp23rffmbyqxc3wjzirh-nixos-system-sshClient-test sshClient # [ 4.360183] initrd-nixos-activation-start[189]: running activation script... machine # [ 4.418521] initrd-nixos-activation-start[188]: booting system configuration /nix/store/1k2q12hb0diqqqx41idaivn5zbdggnc9-nixos-system-machine-test machine # [ 4.444720] initrd-nixos-activation-start[188]: running activation script... sshClient # [ 4.539671] initrd-nixos-activation-start[212]: setting up /etc... machine # [ 4.631350] initrd-nixos-activation-start[211]: setting up /etc... sshClient # [ 4.646824] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. sshClient # [ 4.648214] systemd[1]: Finished NixOS Activation. sshClient # [ 4.650505] systemd[1]: Starting Switch Root... sshClient # [ 4.665537] systemd[1]: Switching root. machine # [ 4.731321] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.733076] systemd[1]: Finished NixOS Activation. machine # [ 4.734681] systemd[1]: Starting Switch Root... machine # [ 4.748085] systemd[1]: Switching root. sshClient # [ 4.938812] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 5.020452] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). sshClient # [ 5.000504] NET: Registered PF_VSOCK protocol family machine # [ 5.081230] NET: Registered PF_VSOCK protocol family sshClient # [ 5.025766] systemd[1]: systemd 263-78a159b running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) sshClient # [ 5.029928] systemd[1]: Detected virtualization kvm. sshClient # [ 5.030644] systemd[1]: Detected architecture x86-64. sshClient # [ 5.031378] systemd[1]: Detected first boot. sshClient # [ 5.033095] systemd[1]: Initializing machine ID from random generator. machine # [ 5.105500] systemd[1]: systemd 263-78a159b running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 5.109534] systemd[1]: Detected virtualization kvm. machine # [ 5.110220] systemd[1]: Detected architecture x86-64. machine # [ 5.110958] systemd[1]: Detected first boot. machine # [ 5.112591] systemd[1]: Initializing machine ID from random generator. sshClient # [ 5.124837] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.198979] systemd[1]: bpf-restrict-fs: LSM BPF program attached sshClient # [ 5.217554] systemd[1]: Applying preset policy. machine # [ 5.291065] systemd[1]: Applying preset policy. sshClient # [ 5.395070] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.463946] systemd[1]: Populated /etc with preset unit settings. sshClient # [ 5.581042] systemd[1]: initrd-switch-root.service: Deactivated successfully. sshClient # [ 5.582448] systemd[1]: Stopped initrd-switch-root.service. sshClient # [ 5.584726] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. sshClient # [ 5.586828] systemd[1]: Created slice Slice /system/getty. sshClient # [ 5.588175] systemd[1]: Created slice User and Session Slice. sshClient # [ 5.589134] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. sshClient # [ 5.590379] systemd[1]: Started Forward Password Requests to Wall Directory Watch. sshClient # [ 5.591540] systemd[1]: Expecting device /dev/hvc0... sshClient # [ 5.592295] systemd[1]: Expecting device /dev/ttyS0... sshClient # [ 5.593042] systemd[1]: Reached target Local Encrypted Volumes. sshClient # [ 5.593847] systemd[1]: Stopped target initrd-fs.target. sshClient # [ 5.594618] systemd[1]: Stopped target initrd-root-fs.target. sshClient # [ 5.595415] systemd[1]: Stopped target initrd-switch-root.target. sshClient # [ 5.596287] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.650885] systemd[1]: initrd-switch-root.service: Deactivated successfully. sshClient # [ 5.597196] systemd[1]: Reached target Path Units. machine # [ 5.652199] systemd[1]: Stopped initrd-switch-root.service. sshClient # [ 5.597934] systemd[1]: Reached target Remote File Systems. sshClient # [ 5.598720] systemd[1]: Reached target Slice Units. sshClient # [ 5.599420] systemd[1]: Reached target Swaps. machine # [ 5.654158] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.656181] systemd[1]: Created slice Slice /system/getty. machine # [ 5.657477] systemd[1]: Created slice User and Session Slice. machine # [ 5.658384] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.659583] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.660693] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.661365] systemd[1]: Expecting device /dev/ttyS0... machine # [ 5.662152] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.662981] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.663746] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.664516] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.665354] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.666249] systemd[1]: Reached target Path Units. machine # [ 5.666943] systemd[1]: Reached target Remote File Systems. sshClient # [ 5.601099] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.667724] systemd[1]: Reached target Slice Units. machine # [ 5.668411] systemd[1]: Reached target Swaps. sshClient # [ 5.614929] systemd[1]: Listening on Process Core Dump Socket. sshClient # [ 5.616665] systemd[1]: Listening on Credential Encryption/Decryption. sshClient # [ 5.618340] systemd[1]: Listening on Factory Reset Management. sshClient # [ 5.619283] systemd[1]: Listening on Hostname Service Socket. sshClient # [ 5.621969] systemd[1]: Starting Journal Log Access Socket... sshClient # [ 5.623479] systemd[1]: Listening on Journal Audit Socket. sshClient # [ 5.626146] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.670042] systemd[1]: Listening on Query the User Interactively for a Password. sshClient # [ 5.627337] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. sshClient # [ 5.628466] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.683872] systemd[1]: Listening on Process Core Dump Socket. sshClient # [ 5.629769] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.685558] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 5.687276] systemd[1]: Listening on Factory Reset Management. sshClient # [ 5.633507] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.688196] systemd[1]: Listening on Hostname Service Socket. sshClient # [ 5.634657] systemd[1]: Listening on udev Varlink Socket. sshClient # [ 5.635581] systemd[1]: Listening on User Database Manager Socket. machine # [ 5.691077] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.692301] systemd[1]: Listening on Journal Audit Socket. sshClient # [ 5.638070] systemd[1]: Mounting Huge Pages File System... sshClient # [ 5.640654] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 5.694971] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.696098] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.697246] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.698561] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.702319] systemd[1]: Listening on Disk Repartitioning Service Socket. sshClient # [ 5.648345] systemd[1]: Mounting Kernel Debug File System... machine # [ 5.703340] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.704212] systemd[1]: Listening on User Database Manager Socket. machine # [ 5.706499] systemd[1]: Mounting Huge Pages File System... machine # [ 5.708920] systemd[1]: Mounting POSIX Message Queue File System... sshClient # [ 5.654890] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.716730] systemd[1]: Mounting Kernel Debug File System... sshClient # [ 5.664731] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.724608] systemd[1]: Mounting Kernel Trace File System... sshClient # [ 5.675119] systemd[1]: Starting Load Kernel Module configfs... machine # [ 5.733049] systemd[1]: Starting Create List of Static Device Nodes... sshClient # [ 5.683572] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.742174] systemd[1]: Starting Load Kernel Module configfs... sshClient # [ 5.692077] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.752096] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm sshClient # [ 5.706157] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.764706] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.771622] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 5.721934] systemd[1]: Mounting FUSE Control File System... sshClient # [ 5.728399] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.787488] systemd[1]: Mounting FUSE Control File System... machine # [ 5.790896] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 sshClient # [ 5.738629] systemd[1]: Starting Journal Service... sshClient # [ 5.742792] systemd[1]: Starting Load Kernel Modules... machine # [ 5.802040] systemd[1]: Starting Journal Service... machine # [ 5.806823] systemd[1]: Starting Load Kernel Modules... sshClient # [ 5.754466] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.816292] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... sshClient # [ 5.765366] systemd[1]: Starting Remount Root and Kernel File Systems... sshClient # [ 5.771479] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.827092] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.832735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.784669] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.845460] systemd[1]: Starting Coldplug All udev Devices... sshClient # [ 5.795030] systemd-journald[283]: Collecting audit messages is enabled. sshClient # [ 5.804243] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.859521] systemd[1]: Listening on Journal Log Access Socket. sshClient # [ 5.808130] systemd[1]: Mounted Huge Pages File System. machine # [ 5.863074] systemd-journald[282]: Collecting audit messages is enabled. machine # [ 5.865536] systemd[1]: Mounted Huge Pages File System. sshClient # [ 5.812064] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 5.869569] systemd[1]: Mounted POSIX Message Queue File System. sshClient # [ 5.815692] systemd[1]: Mounted Kernel Debug File System. sshClient # [ 5.674708] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.874563] systemd[1]: Mounted Kernel Debug File System. sshClient # [ 5.823118] systemd[1]: Started Journal Service. machine # [ 5.877802] loop: module loaded sshClient # [ 5.680879] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. machine # [ 5.879984] systemd[1]: Mounted Kernel Trace File System. sshClient # [ 5.682573] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. sshClient # [ 5.687400] systemd[1]: systemd-journald.service: Deactivated successfully. sshClient # [ 5.688573] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.891751] systemd[1]: Finished Create List of Static Device Nodes. sshClient # [ 5.695936] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 5.748501] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.750393] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. sshClient # [ 5.699162] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 5.898879] systemd[1]: Started Journal Service. machine # [ 5.754414] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. sshClient # [ 5.846973] loop: module loaded machine # [ 5.755738] systemd[1]: systemd-journald.service: Deactivated successfully. sshClient # [ 5.704322] systemd[1]: Finished Load Kernel Module configfs. sshClient # [ 5.705181] systemd[1]: Mounted FUSE Control File System. machine # [ 5.757465] systemd-modules-load[283]: Inserted module 'loop' sshClient # [ 5.708926] systemd-modules-load[284]: Inserted module 'loop' machine # [ 5.761290] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 5.762478] systemd[1]: Finished Load Kernel Module configfs. machine # [ 5.767281] systemd[1]: Finished Load Kernel Modules. machine # [ 5.768112] systemd[1]: Mounted FUSE Control File System. sshClient # [ 5.716929] systemd[1]: Finished Load Kernel Modules. sshClient # [ 5.727104] systemd[1]: Mounting Kernel Configuration File System... sshClient # [ 5.731081] systemd[1]: Starting Firewall... machine # [ 5.787087] systemd[1]: Mounting Kernel Configuration File System... machine # [ 5.792132] systemd[1]: Starting Firewall... sshClient # [ 5.740122] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.939702] EXT4-fs (vda): re-mounted 0366f8ce-a63c-499c-9a0c-53641e19b580. machine # [ 5.796544] systemd[1]: Starting Apply Kernel Variables... sshClient # [ 5.889429] EXT4-fs (vda): re-mounted beb9b0a7-6b97-4823-a932-441fc96bb4ea. machine # [ 5.807201] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... sshClient # [ 5.762099] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 5.816676] systemd[1]: Finished Remount Root and Kernel File Systems. sshClient # [ 5.769872] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 5.823955] systemd[1]: Listening on Disk Image Download Service Socket. sshClient # [ 5.772989] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 5.828209] systemd-oomd[284]: No swap; memory pressure usage will be degraded sshClient # [ 5.781252] systemd-oomd[285]: No swap; memory pressure usage will be degraded sshClient # [ 5.789307] systemd[1]: Starting Flush Journal to Persistent Storage... sshClient # [ 5.790455] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.844085] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.844985] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.855104] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 5.855986] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.807402] systemd[1]: Starting Load/Save OS Random Seed... sshClient # [ 5.808339] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 5.811818] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 5.872388] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 5.920134] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.067803] systemd-journald[282]: Received client request to flush runtime journal. sshClient # [ 6.015500] systemd-journald[283]: Received client request to flush runtime journal. machine # [ 6.007824] systemd[1]: Finished Load/Save OS Random Seed. sshClient # [ 5.955710] systemd[1]: Mounted Kernel Configuration File System. sshClient # [ 5.957713] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.009937] systemd[1]: Finished Apply Kernel Variables. sshClient # [ 5.959417] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.013618] systemd[1]: Finished Flush Journal to Persistent Storage. sshClient # [ 5.962569] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.024179] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.027581] systemd[1]: Starting Create Static Device Nodes in /dev... sshClient # [ 6.005064] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. sshClient # [ 6.012620] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.108722] systemd[1]: Finished Coldplug All udev Devices. sshClient # [ 6.070704] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.125989] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.127378] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.130734] systemd[1]: Starting Rule-based Manager for Device Events and Files... sshClient # [ 6.086913] systemd[1]: Finished Create Static Device Nodes in /dev. sshClient # [ 6.088254] systemd[1]: Reached target Preparation for Local File Systems. sshClient # [ 6.091672] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.175811] systemd-udevd[324]: Using default interface naming scheme 'v261'. machine # [ 6.186273] systemd[1]: Starting User Database Manager... sshClient # [ 6.137036] systemd-udevd[325]: Using default interface naming scheme 'v261'. sshClient # [ 6.148888] systemd[1]: Starting User Database Manager... machine # [ 6.225587] systemd[1]: Started User Database Manager. sshClient # [ 6.189226] systemd[1]: Started User Database Manager. machine # [ 6.276271] systemd[1]: Started Rule-based Manager for Device Events and Files. sshClient # [ 6.246349] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.333103] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse sshClient # [ 6.306689] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.408308] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.441483] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. sshClient # [ 6.400990] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.469277] (udev-worker)[356]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 6.419464] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 6.471664] (udev-worker)[356]: Network interface NamePolicy= disabled on kernel command line. sshClient # [ 6.435225] (udev-worker)[365]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. sshClient # [ 6.438933] (udev-worker)[365]: Network interface NamePolicy= disabled on kernel command line. sshClient # [ 6.443628] systemd[1]: Mounting /run/wrappers... machine # [ 6.510109] systemd[1]: Mounting /run/wrappers... sshClient # [ 6.485828] systemd[1]: Mounted /run/wrappers. sshClient # [ 6.487516] systemd[1]: Reached target Local File Systems. sshClient # [ 6.490474] systemd[1]: Listening on Boot Loader Control Service Socket. sshClient # [ 6.493766] systemd[1]: Starting Create SUID/SGID Wrappers... sshClient # [ 6.495900] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.550323] systemd[1]: Mounted /run/wrappers. machine # [ 6.551111] systemd[1]: Reached target Local File Systems. sshClient # [ 6.500827] systemd[1]: Starting Create System Files and Directories... machine # [ 6.553883] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.559450] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.560345] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.566678] systemd[1]: Starting Create System Files and Directories... machine # [ 6.599107] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.600259] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.601335] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.602773] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.603947] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.607192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.608735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.609956] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.628179] systemd[1]: Finished Create System Files and Directories. sshClient # [ 6.635875] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 6.694257] systemd[1]: Finished Create System Files and Directories. sshClient # [ 6.646914] systemd[1]: Starting Record System Boot/Shutdown in UTMP... sshClient # [ 6.649841] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 6.650929] systemd[1]: Condition check resulted in Virtio network device being skipped. sshClient # [ 6.652074] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.704803] systemd[1]: Starting Rebuild Journal Catalog... sshClient # [ 6.653451] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. sshClient # [ 6.654687] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.709847] systemd[1]: Starting Record System Boot/Shutdown in UTMP... sshClient # [ 6.659971] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore sshClient # [ 6.661490] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os sshClient # [ 6.663134] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.777140] systemd[1]: Finished Record System Boot/Shutdown in UTMP. sshClient # [ 6.735570] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 6.939049] mousedev: PS/2 mouse device common for all mice machine # [ 6.808974] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 6.816908] systemd[1]: Starting Update is Completed... sshClient # [ 6.771089] systemd[1]: Finished Rebuild Journal Catalog. sshClient # [ 6.774960] systemd[1]: Starting Update is Completed... machine # [ 6.863182] systemd[1]: Finished Update is Completed. machine # [ 7.020998] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 sshClient # [ 6.824692] systemd[1]: Finished Update is Completed. machine # [ 7.036979] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 7.044261] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console sshClient # [ 6.997223] mousedev: PS/2 mouse device common for all mice sshClient # [ 7.031876] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 sshClient # [ 7.056451] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console sshClient # [ 6.987317] systemd[1]: Finished Firewall. machine # [ 7.098678] systemd[1]: Finished Firewall. machine # [ 7.062727] ACPI: button: Power Button [PWRF] machine # [ 7.118714] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.143302] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.163976] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 7.164043] rtc_cmos PNP0B00:00: setting system clock to 2026-10-16T02:57:09 UTC (1792119429) machine # [ 7.122974] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.124412] systemd[1]: Reached target System Initialization. machine # [ 7.125327] systemd[1]: Started Discard unused filesystem blocks once a week. sshClient # [ 7.073457] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.126500] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.127564] systemd[1]: Reached target Timer Units. sshClient # [ 7.076957] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.129149] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 7.131064] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine # [ 7.132442] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. sshClient # [ 7.081464] systemd[1]: Reached target System Initialization. machine # [ 7.133944] systemd[1]: Reached target Socket Units. machine # [ 7.134705] systemd[1]: Reached target Basic System. sshClient # [ 7.084097] systemd[1]: Started Discard unused filesystem blocks once a week. sshClient # [ 7.085167] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.137525] systemd[1]: Started backdoor.service. sshClient # [ 7.086111] systemd[1]: Reached target Timer Units. sshClient # [ 7.086923] systemd[1]: Listening on D-Bus System Message Bus Socket. sshClient # [ 7.087859] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. sshClient # [ 7.089228] systemd[1]: Reached target Socket Units. machine # [ 7.141182] systemd[1]: Starting Import lastlog data into lastlog2 database... sshClient # [ 7.089935] systemd[1]: Reached target Basic System. sshClient # [ 7.092244] systemd[1]: Started backdoor.service. machine # [ 7.147068] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 7.097069] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.157103] systemd[1]: Starting Post-Boot Actions... sshClient # [ 7.105144] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 7.116776] systemd[1]: Starting Post-Boot Actions... machine # [ 7.171870] systemd[1]: Started Reset console on configuration changes. machine # [ 7.183405] systemd[1]: Starting resolvconf update... machine # [ 7.164122] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.165003] systemd-journald[282]: Time jumped backwards, rotating. sshClient # [ 7.137331] systemd[1]: Started Reset console on configuration changes. machine # [ 7.194667] systemd[1]: Starting SSH Host Keys Generation... sshClient # [ 7.147553] systemd[1]: Starting resolvconf update... sshClient # [ 7.067628] ACPI: button: Power Button [PWRF] sshClient # [ 7.143918] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.213110] systemd[1]: Starting Home Area Manager... sshClient # [ 7.177641] systemd[1]: Starting Home Area Manager... machine # [ 7.178409] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 7.178499] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 7.189894] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 7.247497] systemd[1]: Finished Post-Boot Actions. sshClient # [ 7.161025] rtc_cmos PNP0B00:00: registered as rtc0 sshClient # [ 7.161090] rtc_cmos PNP0B00:00: setting system clock to 2026-10-16T02:57:09 UTC (1792119429) sshClient # [ 7.161180] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.253754] nsncd[512]: Oct 16 02:57:09.734 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.206074] systemd[1]: Starting D-Bus System Message Bus... machine # connecting to host... machine # [ 7.264325] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.222526] nsncd[506]: Oct 16 02:57:09.702 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.227089] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.279756] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 7.235176] systemd[1]: Finished Post-Boot Actions. machine # [ 7.287724] systemd[1]: Reached target User and Group Name Lookups. sshClient # connecting to host... machine # [ 7.305116] systemd[1]: Starting D-Bus System Message Bus... machine: Guest shell says: b'Spawning backdoor root shell...\n' sshClient # [ 7.256084] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 7.266434] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.328172] systemd[1]: Starting User Login Management... sshClient # [ 7.287253] systemd[1]: Starting User Login Management... machine # [ 7.257446] Console: switching to colour dummy device 80x25 machine # [ 7.360496] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt sshClient # [ 7.162103] systemd-journald[283]: Time jumped backwards, rotating. machine # [ 7.360604] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD sshClient # [ 7.170091] parport_pc 00:02: reported by Plug and Play ACPI machine: connected to guest root shell sshClient # [ 7.170197] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine: (connecting took 8.02 seconds) sshClient # [ 7.178651] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine: (finished: waiting for the VM to finish booting, in 8.02 seconds) machine # [ 7.363211] systemd-homed[519]: Watching /home. sshClient # [ 7.332150] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 7.385963] systemd[1]: Finished Import lastlog data into lastlog2 database. sshClient # [ 7.341854] systemd-homed[511]: Watching /home. machine # [ 7.560160] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 7.560163] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.569388] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 7.576952] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 sshClient # [ 7.195818] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized sshClient # [ 7.302604] Console: switching to colour dummy device 80x25 machine # [ 7.594787] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 7.595491] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 sshClient # [ 7.503230] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt sshClient # [ 7.503390] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD sshClient # [ 7.426958] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... sshClient # [ 7.430502] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' sshClient # [ 7.431595] dbus-broker-launch[514]: Invalid user-name in /nix/store/ppkz17d0akj2p5a4plk619806x2khsbx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" sshClient # [ 7.566814] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 sshClient # [ 7.568155] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 7.533803] systemd-logind[542]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 7.537199] systemd[1]: Starting Virtual Console Setup... machine # [ 7.537973] systemd-logind[542]: New seat seat0. machine # [ 7.543129] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 7.544234] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 7.545250] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 7.547125] systemd[1]: Stopping User and Group Name Lookups... machine # [ 7.551203] dbus-broker-launch[541]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 7.552316] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 7.553200] systemd[1]: Started User Login Management. sshClient # [ 7.649616] [drm] Found bochs VGA, ID 0xb0c5. sshClient # [ 7.649618] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.560052] dbus-broker-launch[541]: NSS returned no entry for 'systemd-timesync' machine # [ 7.561084] dbus-broker-launch[541]: Invalid user-name in /nix/store/n3jrp4vx6px4fy8wgys3k3ga07cidkd2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" sshClient # [ 7.655374] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic sshClient # [ 7.655380] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 sshClient # [ 7.441934] systemd[1]: Stopped target Host and Network Name Lookups. sshClient # [ 7.515497] systemd[1]: Stopping Host and Network Name Lookups... sshClient # [ 7.516518] systemd[1]: Stopped target User and Group Name Lookups. sshClient # [ 7.517573] systemd[1]: Stopping User and Group Name Lookups... machine # [ 7.572469] systemd[1]: nscd.service: Deactivated successfully. sshClient # [ 7.521593] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 7.574624] systemd[1]: Stopped Name Service Cache Daemon (nsncd). sshClient # [ 7.524089] systemd[1]: nscd.service: Deactivated successfully. sshClient # [ 7.525994] systemd[1]: Stopped Name Service Cache Daemon (nsncd). sshClient # [ 7.526865] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 7.527932] systemd[1]: Started D-Bus System Message Bus. sshClient # [ 7.528927] dbus-broker-launch[514]: Ready sshClient # [ 7.533078] systemd-logind[534]: New seat seat0. sshClient # [ 7.533811] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.534569] systemd[1]: Started User Login Management. sshClient # [ 7.542035] systemd[1]: Started Home Area Manager. machine # [ 7.598136] systemd[1]: Starting linger-users.service... sshClient # [ 7.552415] nsncd[581]: Oct 16 02:57:10.032 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" sshClient # [ 7.555484] systemd[1]: Starting linger-users.service... machine # [ 7.609406] systemd[1]: Starting Name Service Cache Daemon (nsncd)... sshClient # [ 7.558102] systemd[1]: Finished Home Area Activation. sshClient # [ 7.562515] systemd[1]: Starting First Boot Home Area Wizard... machine # [ 7.616927] systemd-logind[542]: Watching system buttons on /dev/input/event2 (Power Button) sshClient # [ 7.567177] systemd-logind[534]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) sshClient # [ 7.571191] systemd[1]: Started Name Service Cache Daemon (nsncd). sshClient # [ 7.578459] systemd[1]: Reached target Host and Network Name Lookups. sshClient # [ 7.583921] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.642463] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.650508] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.663159] systemd[1]: Started D-Bus System Message Bus. sshClient # [ 7.621933] systemd-logind[534]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 7.678089] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.640518] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.642866] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.701767] dbus-broker-launch[541]: Ready sshClient # [ 7.657707] systemd[1]: Starting Virtual Console Setup... machine # [ 7.713986] systemd-logind[542]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) sshClient # [ 7.666500] systemd[1]: Finished resolvconf update. machine # [ 7.720229] systemd[1]: Started Home Area Manager. sshClient # [ 7.672892] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 7.725173] systemd[1]: Finished Home Area Activation. sshClient # [ 7.675385] systemd[1]: Finished linger-users.service. machine # [ 7.732575] systemd[1]: Starting First Boot Home Area Wizard... sshClient # [ 7.683094] systemd[1]: Reached target Preparation for Network. machine # [ 7.741073] systemd[1]: linger-users.service: Deactivated successfully. sshClient # [ 7.691301] systemd[1]: Starting DHCP Client... sshClient # [ 7.694115] systemd[1]: Starting Address configuration of eth1... machine # [ 7.747422] systemd[1]: Finished linger-users.service. sshClient # [ 7.698050] systemd[1]: Starting Extra networking commands.... machine # [ 7.919077] Console: switching to colour frame buffer device 160x50 sshClient # [ 7.889199] Console: switching to colour frame buffer device 160x50 machine # [ 7.969190] ppdev: user-space parallel port driver machine # [ 7.994331] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 7.757764] nsncd[603]: Oct 16 02:57:10.238 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.851748] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.852673] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.855747] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.858852] systemd[1]: Finished resolvconf update. machine # [ 7.861509] systemd[1]: Reached target Preparation for Network. machine # [ 7.862828] systemd[1]: Starting DHCP Client... machine # [ 7.864894] systemd[1]: Starting Address configuration of eth1... sshClient # [ 7.893186] ppdev: user-space parallel port driver sshClient # [ 7.943935] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 7.866256] systemd[1]: Starting Extra networking commands.... sshClient # [ 7.958057] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device sshClient # [ 7.785984] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 8.014671] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) sshClient # [ 7.822723] systemd-vconsole-setup[614]: Failed to enable UTF-8 term processing on /dev/tty1: Input/output error sshClient # [ 7.826144] systemd[1]: Finished First Boot Home Area Wizard. sshClient # [ 7.833107] systemd[1]: Reached target First Boot Complete. sshClient # [ 7.840499] network-addresses-eth1-start[618]: adding address 192.168.1.2/24... done sshClient # [ 7.842190] systemd[1]: Starting Save Transient machine-id to Disk... sshClient # [ 7.996917] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) sshClient # [ 7.866264] network-addresses-eth1-start[618]: adding address 2001:db8:1::2/64... done machine # [ 8.085920] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) sshClient # [ 7.901137] systemd[1]: Finished Address configuration of eth1. machine # [ 7.989149] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.992063] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.012878] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.961529] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. sshClient # [ 7.965252] systemd[1]: Stopped Virtual Console Setup. sshClient # [ 7.974937] systemd[1]: Starting Virtual Console Setup... sshClient # [ 7.993654] dhcpcd[629]: dhcpcd-10.3.2 starting machine # [ 8.054702] network-addresses-eth1-start[635]: adding address 192.168.1.1/24... done sshClient # [ 8.007981] dhcpcd[687]: dev: loaded udev machine # [ 8.084811] systemd[1]: Created slice Slice /system/systemd-mute-console. sshClient # [ 8.033706] systemd[1]: Finished Extra networking commands.. sshClient # [ 8.037893] systemd[1]: Reached target Network. machine # [ 8.091975] systemd[1]: Started Console Output Muting Service (PID 617/UID 0). machine # [ 8.100243] network-addresses-eth1-start[635]: adding address 2001:db8:1::1/64... done sshClient # [ 8.065129] systemd[1]: Starting Permit User Sessions... sshClient # [ 8.066825] systemd[1]: Finished Save Transient machine-id to Disk. sshClient # [ 8.215128] 8021q: 802.1Q VLAN Support v1.8 sshClient # [ 8.215580] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.147687] systemd[1]: Finished Address configuration of eth1. sshClient # [ 8.247553] kvm_amd: TSC scaling supported sshClient # [ 8.248042] kvm_amd: Nested Virtualization enabled sshClient # [ 8.248767] kvm_amd: Nested Paging enabled sshClient # [ 8.249194] kvm_amd: LBR virtualization supported sshClient # [ 8.249853] kvm_amd: Virtual VMLOAD VMSAVE supported sshClient # [ 8.250512] kvm_amd: Virtual GIF supported sshClient # [ 8.250982] kvm_amd: Virtual NMI enabled sshClient # [ 8.137234] systemd[1]: Finished Permit User Sessions. sshClient # [ 8.142169] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. sshClient # [ 8.146737] systemd[1]: Started Getty on tty1. sshClient # [ 8.148924] systemd[1]: Reached target Login Prompts. sshClient # [ 8.345504] EDAC MC: Ver: 3.0.0 sshClient # [ 8.349609] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 8.271659] dhcpcd[644]: dhcpcd-10.3.2 starting sshClient # [ 8.365594] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' sshClient # [ 8.366528] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' sshClient # [ 8.368394] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 sshClient # [ 8.369273] cfg80211: failed to load regulatory.db machine # [ 8.295136] dhcpcd[705]: dev: loaded udev machine # [ 8.297846] systemd[1]: Finished Extra networking commands.. machine # [ 8.301735] systemd[1]: Reached target Network. sshClient # [ 8.397896] 8021q: adding VLAN 0 to HW filter on device eth0 sshClient # [ 8.255673] dhcpcd[687]: eth0: waiting for carrier sshClient # [ 8.256601] dhcpcd[687]: eth0: carrier acquired sshClient # [ 8.261741] dhcpcd[687]: DUID 00:01:00:01:32:64:4f:06:52:54:00:12:34:56 sshClient # [ 8.263083] dhcpcd[687]: eth0: IAID 00:12:34:56 sshClient # [ 8.263799] dhcpcd[687]: eth0: adding address fe80::5054:ff:fe12:3456 sshClient # [ 8.306178] systemd-vconsole-setup[681]: Configuration of first virtual console was skipped, ignoring remaining ones. sshClient # [ 8.309185] systemd[1]: Finished Virtual Console Setup. machine # [ 8.373534] sshd-keygen-start[574]: Generating public/private rsa key pair. machine # [ 8.374510] sshd-keygen-start[574]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine # [ 8.375652] sshd-keygen-start[574]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine # [ 8.376764] sshd-keygen-start[574]: The key fingerprint is: machine # [ 8.377454] sshd-keygen-start[574]: SHA256:y9tnfvt0qdoXQlWkQa3JWdgb/f6Tmp65qmldSCS049M root@machine machine # [ 8.379024] sshd-keygen-start[574]: The key's randomart image is: machine # [ 8.379893] sshd-keygen-start[574]: +---[RSA 4096]----+ machine # [ 8.380768] sshd-keygen-start[574]: | .. .o==| machine # [ 8.381513] sshd-keygen-start[574]: | ... .==| machine # [ 8.382231] sshd-keygen-start[574]: | oo .o=+| machine # [ 8.382918] sshd-keygen-start[574]: | . o. .=..| machine # [ 8.383608] sshd-keygen-start[574]: | So.Eo . | machine # [ 8.384415] sshd-keygen-start[574]: | . ... o .o| machine # [ 8.385120] sshd-keygen-start[574]: | o . . ..*| machine # [ 8.385777] sshd-keygen-start[574]: | +..+ *=o| machine # [ 8.386533] sshd-keygen-start[574]: | ooo*=@=oo| machine # [ 8.387220] sshd-keygen-start[574]: +----[SHA256]-----+ machine # [ 8.410225] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 8.479118] sshd-keygen-start[716]: Generating public/private ed25519 key pair. machine # [ 8.480132] sshd-keygen-start[716]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine # [ 8.481318] sshd-keygen-start[716]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine # [ 8.482480] sshd-keygen-start[716]: The key fingerprint is: machine # [ 8.483192] sshd-keygen-start[716]: SHA256:QJ0V5DtAcfTeZgW3RIks0KNVMGPJD7I9dA6zcy8kIN0 root@machine machine # [ 8.484881] sshd-keygen-start[716]: The key's randomart image is: machine # [ 8.485715] sshd-keygen-start[716]: +--[ED25519 256]--+ machine # [ 8.486508] sshd-keygen-start[716]: | ..+B@*=.+oo| machine # [ 8.487195] sshd-keygen-start[716]: | . oo*.Eo+.+.| machine # [ 8.487863] sshd-keygen-start[716]: | . o X % ..| machine # [ 8.488509] sshd-keygen-start[716]: | . + O * . | machine # [ 8.489213] sshd-keygen-start[716]: | S o B = | machine # [ 8.489848] sshd-keygen-start[716]: | . + . | machine # [ 8.490592] sshd-keygen-start[716]: | . | machine # [ 8.491295] sshd-keygen-start[716]: | | machine # [ 8.491978] sshd-keygen-start[716]: | | machine # [ 8.492674] sshd-keygen-start[716]: +----[SHA256]-----+ machine # [ 8.495307] systemd[1]: sshd-keygen.service: Deactivated successfully. machine # [ 8.497154] systemd[1]: Finished SSH Host Keys Generation. machine # [ 8.501143] systemd[1]: Starting SSH Daemon... machine # [ 8.546994] sshd[719]: Server listening on 0.0.0.0 port 22. machine # [ 8.548840] sshd[719]: Server listening on :: port 22. machine # [ 8.550222] systemd[1]: Started SSH Daemon. machine # [ 8.558558] dhcpcd[705]: eth0: waiting for carrier machine # [ 8.559382] dhcpcd[705]: eth0: carrier acquired machine # [ 8.566894] dhcpcd[705]: DUID 00:01:00:01:32:64:4f:07:52:54:00:12:34:56 machine # [ 8.568094] dhcpcd[705]: eth0: IAID 00:12:34:56 machine # [ 8.568781] dhcpcd[705]: eth0: adding address fe80::5054:ff:fe12:3456 machine: (finished: waiting for unit systemd-homed.service, in 9.25 seconds) machine: waiting for Please enter user name to create to appear on tty 1 sshClient # [ 8.547438] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.627627] systemd-vconsole-setup[650]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.632327] systemd[1]: Finished Virtual Console Setup. machine # [ 9.275036] dhcpcd[705]: eth0: soliciting a DHCP lease machine # [ 9.286458] dhcpcd[705]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.287466] dhcpcd[705]: eth0: probing address 10.0.2.15/24 sshClient # [ 9.543649] dhcpcd[687]: eth0: soliciting a DHCP lease sshClient # [ 9.704391] NET: Registered PF_PACKET protocol family sshClient # [ 9.566926] dhcpcd[687]: eth0: offered 10.0.2.15 from 10.0.2.2 sshClient # [ 9.570490] dhcpcd[687]: eth0: probing address 10.0.2.15/24 machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 1.08 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 # [ 10.205082] dhcpcd[687]: eth0: soliciting an IPv6 router sshClient # [ 10.207945] dhcpcd[687]: eth0: Router Advertisement from fe80::2 sshClient # [ 10.210244] dhcpcd[687]: eth0: adding address fec0::5054:ff:fe12:3456/64 sshClient # [ 10.212561] dhcpcd[687]: eth0: adding route to fec0::/64 sshClient # [ 10.214554] dhcpcd[687]: eth0: adding default route via fe80::2 machine # [ 10.505458] dhcpcd[705]: eth0: soliciting an IPv6 router machine # [ 10.506718] dhcpcd[705]: eth0: Router Advertisement from fe80::2 machine # [ 10.507549] dhcpcd[705]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 10.508410] dhcpcd[705]: eth0: adding route to fec0::/64 machine # [ 10.509205] dhcpcd[705]: 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.07 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.04 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 # [ 14.736651] dhcpcd[705]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 14.739259] dhcpcd[705]: eth0: adding route to 10.0.2.0/24 machine # [ 14.742139] dhcpcd[705]: eth0: adding default route via 10.0.2.2 machine # [ 14.824322] systemd[1]: Started DHCP Client. sshClient # [ 15.131645] dhcpcd[687]: eth0: leased 10.0.2.15 for 86400 seconds sshClient # [ 15.134458] dhcpcd[687]: eth0: adding route to 10.0.2.0/24 sshClient # [ 15.136934] dhcpcd[687]: eth0: adding default route via 10.0.2.2 sshClient # [ 15.224333] systemd[1]: Started DHCP Client. sshClient # [ 15.225971] systemd[1]: Reached target Multi-User System. sshClient # [ 15.227251] systemd[1]: Startup finished in 846ms (kernel) + 3.989s (initrd) + 10.391s (userspace) = 15.227s. machine # [ 22.298622] systemd-homed[519]: Generating key pair for signing local user identity records. machine # [ 22.303418] systemd-homed[519]: Successfully created Ed25519 key pair. machine # [ 22.321348] systemd-homed[519]: test-homed-user: changing state absent → creating machine # [ 22.389614] systemd-homework[878]: Using automatic default storage of 'luks'. machine # [ 22.393525] systemd-homework[878]: Sizing home to 83% of available disk space, which is 743M. machine # [ 22.395381] systemd-homework[878]: Allocating image file completed. machine # [ 22.417723] systemd-homework[878]: Writing of partition table completed. machine # [ 22.420171] systemd-homework[878]: Setting up loopback device /dev/loop0 completed. machine # [ 23.671268] systemd-homework[878]: LUKS formatting completed. machine # [ 25.367361] systemd-homework[878]: Writing password to LUKS keyslot 0 completed. machine # [ 25.566749] systemd-homework[878]: LUKS activation by volume key succeeded. machine # [ 25.584665] systemd-homework[878]: Writing user record as LUKS token completed. machine # [ 25.586159] systemd-homework[878]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 25.587289] systemd-homework[878]: Formatting /dev/mapper/home-test-homed-user as btrfs machine # [ 25.942655] systemd[1]: proc-909-mounts.mount: Deactivated successfully. machine # [ 25.943916] systemd-homework[878]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid 34ab1021-4c1b-41e8-a2fb-a7907ed51083) machine # [ 25.945775] systemd-homework[878]: Formatting file system completed. machine # [ 25.983275] systemd-homework[878]: Mounting file system completed. machine # [ 25.985611] systemd-homework[878]: Skeleton directory /etc/skel missing, ignoring. machine # [ 25.986679] systemd-homework[878]: Wrote embedded .identity file. machine # [ 25.987532] systemd-homework[878]: Replaced embedded blob dir with contents of system blob dir. machine # [ 25.988620] systemd-homework[878]: Recursive changing of ownership completed. machine # [ 25.989590] systemd-homework[878]: Changed top-level directory access mode to 0700. machine # [ 25.999910] systemd-homework[878]: Synchronized disk. machine # [ 26.001443] systemd-homework[878]: Discarded unused 651.8M. machine # [ 26.009245] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 26.019448] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 26.030454] (udev-worker)[902]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.033178] (udev-worker)[902]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.035424] (udev-worker)[902]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.037987] (udev-worker)[902]: loop0: Failed to add device watch, ignoring: No such file or directory machine # [ 26.040616] systemd-homed[519]: block device /sys/devices/virtual/block/loop0 has been removed. machine # [ 26.042577] systemd-homework[878]: Moved image file into place. machine # [ 26.045484] systemd-homework[878]: Creation completed. machine # [ 26.046287] systemd-homework[878]: Image size is 743M, file system size is 725M, file system payload size is 725M, file system free is 718.9M. machine # [ 26.054631] systemd-homed[519]: test-homed-user: changing state creating → inactive machine # [ 26.060552] systemd[1]: Finished First Boot Home Area Wizard. machine # [ 26.063144] systemd[1]: systemd-mute-console@0-1-617_618-0.service: Deactivated successfully. machine # [ 26.067251] systemd[1]: Reached target First Boot Complete. machine # [ 26.069776] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 26.073336] systemd[1]: Starting Permit User Sessions... machine # [ 26.095144] systemd[1]: Finished Permit User Sessions. machine # [ 26.099295] systemd[1]: Started Getty on tty1. machine # [ 26.101198] systemd[1]: Reached target Login Prompts. machine # [ 26.102690] systemd[1]: Reached target Multi-User System. machine # [ 26.137605] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 26.140266] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 26.142624] systemd[1]: Startup finished in 869ms (kernel) + 4.043s (initrd) + 21.228s (userspace) = 26.141s. machine: (finished: waiting for unit systemd-homed-firstboot.service, in 14.82 seconds) (finished: subtest: create systemd-homed user on first boot prompt, in 27.64 seconds) machine: must succeed: homectl update test-homed-user --offline -G wheel machine # [ 27.014316] systemd-homed[519]: test-homed-user: changing state inactive → updating machine # [ 27.021580] systemd-homework[955]: Offline update requested. Not touching embedded records. machine # [ 27.025060] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 27.032245] systemd-homed[519]: test-homed-user: changing state updating → inactive machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.06 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.397976] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 27.408335] systemd-homework[970]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 27.418402] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 27.422952] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 27.426086] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 27.429633] 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.10 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.514428] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 28.553576] systemd-homework[982]: Provided password unlocks user record. machine # [ 28.557145] systemd-homework[982]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 28.565068] systemd-homework[982]: Allocated additional 651.8M. machine # [ 28.714187] loop1: detected capacity change from 0 to 1517568 machine # [ 28.569453] systemd-homework[982]: Setting up loopback device /dev/loop1 completed. machine # [ 29.420318] systemd-homework[982]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 29.443445] systemd-homework[982]: Provided password unlocks user record. machine # [ 29.449548] systemd-homework[982]: Probing file system completed (found btrfs). machine # [ 29.451586] systemd-homework[982]: No fsck for file system btrfs installed, ignoring. machine # [ 29.599249] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (982) machine # [ 29.601857] BTRFS info (device dm-0): first mount of filesystem 34ab1021-4c1b-41e8-a2fb-a7907ed51083 machine # [ 29.602888] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 29.607689] BTRFS info (device dm-0): enabling free space tree machine # [ 29.608237] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 29.463694] systemd-homework[982]: Mounting file system completed. machine # [ 29.465271] systemd-homework[982]: Discovered used loopback device /dev/loop1. machine # [ 29.466309] systemd-homework[982]: offset = 1048576, size = 776994816, image = 779091968 machine # [ 29.477950] systemd-homework[982]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M. machine # [ 29.479734] systemd-homework[982]: Growing of image file from 743M to 896M completed. machine # [ 29.627596] loop1: detected capacity change from 1517568 to 1830912 machine # [ 29.483701] systemd-homework[982]: Refreshing loop device size completed. machine # [ 29.502219] systemd-homework[982]: Growing of partition completed. machine # [ 29.676487] async_tx: api initialized (async) machine # [ 29.561417] systemd-homework[982]: LUKS device growing completed. machine # [ 29.714685] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 920649728 machine # [ 29.570370] systemd-homework[982]: File system resizing from 725M to 878M completed. machine # [ 29.573053] systemd-homework[982]: Synchronized disk. machine # [ 29.573745] systemd-homework[982]: Synchronized disk. machine # [ 29.574442] systemd-homework[982]: Resizing completed. machine # [ 29.575232] systemd-homework[982]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 29.576782] systemd-homework[982]: Read embedded .identity file. machine # [ 29.594735] systemd-homework[982]: Provided password unlocks user record. machine # [ 29.595789] systemd-homework[982]: Reconciling header user identity completed (host version was newer). machine # [ 29.597054] systemd-homework[982]: Reconciling embedded user identity completed (host version was newer). machine # [ 29.613480] systemd-homework[982]: Wrote LUKS header user record. machine # [ 29.614492] systemd-homework[982]: Wrote embedded .identity file. machine # [ 29.615309] systemd-homework[982]: Replaced embedded blob dir with contents of system blob dir. machine # [ 29.616415] systemd-homework[982]: Recursive changing of ownership not necessary, skipped. machine # [ 29.623925] systemd-homework[982]: Synchronized disk. machine # [ 29.625895] systemd-homework[982]: Moving to final mount point /home/test-homed-user completed. machine # [ 29.646597] systemd-homework[982]: Activation completed. machine # [ 29.648243] systemd-homework[982]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M. machine # [ 29.657524] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 29.664529] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → active machine # [ 29.666167] login[946]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired. machine # [ 29.673472] systemd-homed[519]: test-homed-user: changing state active → resizing-while-active machine # [ 29.681874] systemd-homework[1024]: Successfully acquired home volume key from kernel keyring. machine # [ 29.683879] systemd-homework[1024]: LUKS volume key from keyring unlocks user record. machine # [ 29.736375] login[946]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0) machine # [ 29.779825] systemd-homework[1024]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 29.801082] systemd[1]: Created slice Slice /user/60388. machine # [ 29.803519] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 29.818317] systemd-logind[542]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'. machine # [ 29.860143] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 29.871132] systemd[1]: Starting User Manager for UID 60388... machine # [ 29.920383] (systemd)[1030]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 29.970908] (systemd)[1030]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 29.978224] systemd-logind[542]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 30.029184] systemd[1030]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.068078] systemd-homework[1024]: Successfully re-activated LUKS device. machine # [ 30.071309] systemd-homework[1024]: LUKS volume key from keyring unlocks user record. machine # [ 30.072733] systemd-homework[1024]: Discovered used loopback device /dev/loop1. machine # [ 30.073987] systemd-homework[1024]: Read embedded .identity file. machine # [ 30.075545] systemd-homework[1024]: LUKS volume key from keyring unlocks user record. machine # [ 30.076659] systemd-homework[1024]: Reconciling header user identity completed (host version was newer). machine # [ 30.077912] systemd-homework[1024]: Reconciling embedded user identity completed (host version was newer). machine # [ 30.079126] systemd-homework[1024]: offset = 1048576, size = 937426944, image = 939524096 machine # [ 30.096521] systemd-homework[1024]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M. machine # [ 30.098442] systemd-homework[1024]: Wrote embedded .identity file. machine # [ 30.099688] systemd-homework[1024]: Replaced embedded blob dir with contents of system blob dir. machine # [ 30.100816] systemd-homework[1024]: Backing file is fully allocated already. machine # [ 30.251421] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 782237696 machine # [ 30.107859] systemd-homework[1024]: File system resizing from 878M to 746M completed. machine # [ 30.113400] systemd-homework[1024]: Synchronized disk. machine # [ 30.151265] systemd-homework[1024]: LUKS device shrinking completed. machine # [ 30.300710] loop1: detected capacity change from 1830912 to 1560576 machine # [ 30.157060] systemd-homework[1024]: Refreshing loop device size completed. machine # [ 30.158412] systemd-homework[1024]: Shrinking of image file completed. machine # [ 30.177925] systemd-homework[1024]: Shrinking of partition completed. machine # [ 30.193681] systemd-homework[1024]: Wrote LUKS header user record. machine # [ 30.194840] systemd-homework[1024]: Synchronized disk. machine # [ 30.199821] systemd-homework[1024]: Resizing completed. machine # [ 30.200651] systemd-homework[1024]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 30.203115] systemd[1030]: Queued start job for default target Main User Target. machine # [ 30.207267] systemd[1030]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.210390] systemd[1030]: Created slice User Application Slice. machine # [ 30.212255] systemd[1030]: Started Daily Cleanup of User's Temporary Directories. machine # [ 30.214127] systemd[1030]: Reached target Paths. machine # [ 30.214867] systemd[1030]: Reached target Timers. machine # [ 30.218294] systemd[1030]: Starting D-Bus User Message Bus Socket... machine # [ 30.222092] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 30.223326] systemd[1030]: Starting Create User Files and Directories... machine # [ 30.231176] systemd-homed[519]: test-homed-user: changing state resizing-while-active → active machine # [ 30.232356] systemd-homed[519]: Rebalancing complete. machine # [ 30.255971] systemd[1030]: Finished Create User Files and Directories. machine # [ 30.267568] systemd[1030]: Listening on D-Bus User Message Bus Socket. machine # [ 30.268514] systemd[1030]: Reached target Sockets. machine # [ 30.269239] systemd[1030]: Reached target Basic System. machine # [ 30.269987] systemd[1]: Started User Manager for UID 60388. machine # [ 30.273125] systemd[1030]: Starting Run user-specific NixOS activation... machine # [ 30.277372] systemd[1]: Started Session 1 of User test-homed-user. machine # [ 30.302700] systemd[1030]: Finished Run user-specific NixOS activation. machine # [ 30.303957] systemd[1030]: Reached target Main User Target. machine # [ 30.304900] systemd[1030]: Startup finished in 293ms. machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.12 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.06 seconds) machine: must succeed: cat /tmp/2 machine: (finished: must succeed: cat /tmp/2, in 0.03 seconds) (finished: subtest: login as homed user, in 4.77 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.04 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.05 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.224760] login[696]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0) sshClient # [ 33.251252] systemd-logind[534]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'. sshClient # [ 33.268212] systemd[1]: Created slice Slice /user/1000. sshClient # [ 33.269088] systemd[1]: Starting User Runtime Directory /run/user/1000... sshClient # [ 33.300125] systemd[1]: Finished User Runtime Directory /run/user/1000. sshClient # [ 33.304085] systemd[1]: Starting User Manager for UID 1000... sshClient # [ 33.326339] (systemd)[813]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0) sshClient # [ 33.331890] systemd-logind[534]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'. sshClient # [ 33.348413] systemd[813]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 33.444093] systemd[813]: Queued start job for default target Main User Target. sshClient # [ 33.447866] systemd[813]: Failed to adjust io pressure threshold, ignoring: Device or resource busy sshClient # [ 33.450176] systemd[813]: Created slice User Application Slice. sshClient # [ 33.451199] systemd[813]: Started Daily Cleanup of User's Temporary Directories. sshClient # [ 33.452338] systemd[813]: Reached target Paths. sshClient # [ 33.454059] systemd[813]: Reached target Timers. sshClient # [ 33.456079] systemd[813]: Starting D-Bus User Message Bus Socket... sshClient # [ 33.457965] systemd[813]: Starting Create User Files and Directories... sshClient # [ 33.488265] systemd[813]: Finished Create User Files and Directories. sshClient # [ 33.504103] systemd[813]: Listening on D-Bus User Message Bus Socket. sshClient # [ 33.506509] systemd[813]: Reached target Sockets. sshClient # [ 33.507218] systemd[813]: Reached target Basic System. sshClient # [ 33.508038] systemd[1]: Started User Manager for UID 1000. sshClient # [ 33.510925] systemd[813]: Starting Run user-specific NixOS activation... sshClient # [ 33.515881] systemd[1]: Started Session 1 of User test-normal-user. sshClient # [ 33.545083] systemd[813]: Finished Run user-specific NixOS activation. sshClient # [ 33.546155] systemd[813]: Reached target Main User Target. sshClient # [ 33.547484] systemd[813]: Startup finished in 204ms. sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.06 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.04 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.66 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.03 seconds) sshClient: must succeed: cat /tmp/id_ed25519.pub sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.01 seconds) machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFje5eFJapvyJpXHkt+xKulBvq2x6t2Vw8VQhUkJSW/B test-normal-user@sshClient' machine # [ 37.025811] systemd-homed[519]: test-homed-user: changing state active → updating-while-active machine # [ 37.030149] systemd-homework[1078]: Offline update requested. Not touching embedded records. machine # [ 37.037524] 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 AAAAC3NzaC1lZDI1NTE5AAAAIFje5eFJapvyJpXHkt+xKulBvq2x6t2Vw8VQhUkJSW/B test-normal-user@sshClient', in 0.04 seconds) machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519 machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.02 seconds) (finished: subtest: add homed ssh authorized key, in 1.58 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.11 seconds) machine: sending keys 'barfoobar\n' machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds) machine: waiting for Retype new password: to appear on tty 1 machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.10 seconds) machine: sending keys 'barfoobar\n' machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds) ??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead. File "/nix/store/2bhsk8wfsfr8v5d88sjwrmfb3mv2fxwa-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 573 machine: must succeed: sleep 4.0 machine # [ 39.864928] systemd-homed[519]: test-homed-user: changing state active → passwd-while-active machine # [ 40.630457] systemd-homework[1117]: No valid password for LUKS superblock. machine # [ 42.879806] systemd-homed[519]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 42.884583] 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.004132] systemd-homed[519]: test-homed-user: changing state active → passwd-while-active machine # [ 45.317969] systemd-homework[1123]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 45.450606] systemd-homework[1123]: Successfully re-activated LUKS device. machine # [ 45.489705] systemd-homework[1123]: Provided password unlocks user record. machine # [ 45.492059] systemd-homework[1123]: Discovered used loopback device /dev/loop1. machine # [ 45.492983] systemd-homework[1123]: Read embedded .identity file. machine # [ 45.528753] systemd-homework[1123]: Provided password unlocks user record. machine # [ 45.529759] systemd-homework[1123]: Reconciling header user identity completed (host version was newer). machine # [ 45.530933] systemd-homework[1123]: Reconciling embedded user identity completed (host version was newer). machine # [ 48.510882] systemd-homework[1123]: Added LUKS key slot 1. machine # [ 48.543163] systemd-homework[1123]: Destroyed LUKS key slot 0. machine # [ 48.553434] systemd-homework[1123]: Wrote LUKS header user record. machine # [ 48.554361] systemd-homework[1123]: Wrote embedded .identity file. machine # [ 48.555595] systemd-homework[1123]: Replaced embedded blob dir with contents of system blob dir. machine # [ 48.561024] systemd-homework[1123]: Synchronized disk. machine # [ 48.565205] systemd-homework[1123]: Everything completed. machine # [ 48.576484] passwd[1092]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user. machine # [ 48.579543] systemd-homed[519]: test-homed-user: changing state passwd-while-active → active machine: (finished: waiting for file '/tmp/3', in 5.15 seconds) machine: must succeed: cat /tmp/3 machine: (finished: must succeed: cat /tmp/3, in 0.03 seconds) (finished: subtest: change homed user password, in 11.99 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 # [ 49.521482] systemd-homed[519]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 49.530758] systemd-homework[1159]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 49.539857] systemd-homed[519]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 49.544759] 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.08 seconds) machine: sending keys 'barfoobar\n' machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds) machine: waiting for file '/tmp/4' machine: (finished: waiting for file '/tmp/4', in 0.01 seconds) machine: waiting for success: grep uid=0 /tmp/4 machine # [ 50.541509] systemd-homed[519]: test-homed-user: changing state active → authenticating-for-acquire machine # [ 50.568593] systemd-homework[1175]: Provided password unlocks user record. machine # [ 51.340138] systemd-homework[1175]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 51.495127] systemd-homework[1175]: Successfully re-activated LUKS device. machine # [ 51.535229] systemd-homework[1175]: Provided password unlocks user record. machine # [ 51.536417] systemd-homework[1175]: Discovered used loopback device /dev/loop1. machine # [ 51.537776] systemd-homework[1175]: Read embedded .identity file. machine # [ 51.560505] systemd-homework[1175]: Provided password unlocks user record. machine # [ 51.562872] systemd-homework[1175]: Reconciling user identities completed (host and header version were identical). machine # [ 51.564691] systemd-homework[1175]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 51.576343] systemd-homework[1175]: Everything completed. machine # [ 51.582076] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 51.594830] sudo[1157]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired. machine # [ 51.598950] systemd-homed[519]: test-homed-user: changing state authenticating-for-acquire → active machine # [ 51.608932] sudo[1157]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id machine # [ 51.639341] sudo[1157]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388) machine # [ 51.654492] sudo[1157]: pam_unix(sudo:session): session closed for user root machine: (finished: waiting for success: grep uid=0 /tmp/4, in 2.08 seconds) (finished: subtest: escalate to root from homed user, in 3.49 seconds) subtest: log out and deactivate homed user's home area machine: sending keys 'exit\n' machine: (finished: sending keys 'exit\n', in 0.06 seconds) machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive' machine # [ 52.634760] login[946]: pam_unix(login:session): session closed for user test-homed-user machine # [ 52.637347] login[946]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 52.643837] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 52.653860] systemd[1]: session-1.scope: Deactivated successfully. machine # [ 52.657884] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. machine # [ 52.661363] systemd-logind[542]: Session 1 logged out. Waiting for processes to exit. machine # [ 52.664611] systemd[1]: Started Getty on tty1. machine # [ 52.667152] systemd-logind[542]: Removed session 1. machine # [ 62.868587] systemd[1]: Stopping User Manager for UID 60388... machine # [ 62.877654] systemd[1030]: Activating special unit Exit the Session... machine # [ 62.883918] systemd[1030]: Stopped target Main User Target. machine # [ 62.887807] systemd[1030]: Stopped Run user-specific NixOS activation. machine # [ 62.890697] systemd[1030]: Stopped target Basic System. machine # [ 62.894569] systemd[1030]: Stopped target Paths. machine # [ 62.897610] systemd[1030]: Stopped target Sockets. machine # [ 62.900345] systemd[1030]: Stopped target Timers. machine # [ 62.902487] systemd[1030]: Stopped Daily Cleanup of User's Temporary Directories. machine # [ 62.904928] systemd[1030]: Closed D-Bus User Message Bus Socket. machine # [ 62.908351] systemd[1030]: Stopped Create User Files and Directories. machine # [ 62.911496] systemd[1030]: Removed slice User Application Slice. machine # [ 62.916339] systemd[1030]: Reached target Shutdown. machine # [ 62.918804] systemd[1030]: Finished Exit the Session. machine # [ 62.921370] systemd[1030]: Reached target Exit the Session. machine # [ 62.924662] systemd-logind[542]: Removed session 2. machine # [ 62.930867] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 62.937333] systemd-homed[519]: test-homed-user: changing state active → deactivating machine # [ 62.939410] systemd[1]: user@60388.service: Deactivated successfully. machine # [ 62.941253] systemd[1]: Stopped User Manager for UID 60388. machine # [ 62.947819] systemd-homework[1258]: Successfully acquired home volume key from kernel keyring. machine # [ 62.950163] systemd-homework[1258]: Discarded unused 673.5M. machine # [ 62.959697] systemd-homework[1258]: Syncing completed. machine # [ 62.961748] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully. machine # [ 62.968767] systemd[1]: Stopping User Runtime Directory /run/user/60388... machine # [ 63.014891] systemd[1]: run-user-60388.mount: Deactivated successfully. machine # [ 63.018732] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully. machine # [ 63.021120] systemd[1]: Stopped User Runtime Directory /run/user/60388. machine # [ 63.057140] systemd-homework[1258]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password. machine # [ 63.188708] systemd-homework[1258]: Successfully re-activated LUKS device. machine # [ 63.190305] systemd-homework[1258]: Discovered used loopback device /dev/loop1. machine # [ 63.191936] systemd-homework[1258]: offset = 1048576, size = 799014912, image = 801112064 machine # [ 63.207177] systemd-homework[1258]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M. machine # [ 63.209410] systemd-homework[1258]: Allocated additional 673.5M. machine # [ 63.362500] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 268435456 machine # [ 63.218252] systemd-homework[1258]: File system resizing from 746M to 256M completed. machine # [ 63.219576] systemd-homework[1258]: Synchronized disk. machine # [ 63.316927] systemd-homework[1258]: LUKS device shrinking completed. machine # [ 63.464512] loop1: detected capacity change from 1560576 to 557056 machine # [ 63.321373] systemd-homework[1258]: Refreshing loop device size completed. machine # [ 63.323338] systemd-homework[1258]: Shrinking of image file completed. machine # [ 63.343928] systemd-homework[1258]: Shrinking of partition completed. machine # [ 63.345062] systemd-homework[1258]: Synchronized disk. machine # [ 63.345756] systemd-homework[1258]: Resizing completed. machine # [ 63.346531] systemd-homework[1258]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M. machine # [ 63.493667] BTRFS info (device dm-0): last unmount of filesystem 34ab1021-4c1b-41e8-a2fb-a7907ed51083 machine # [ 63.351556] systemd-homework[1258]: Unmounting completed. machine # [ 63.352806] systemd-homework[1258]: Discovered used LUKS device /dev/mapper/home-test-homed-user. machine # [ 63.354742] systemd-homework[1258]: Device home-test-homed-user is not active. machine # [ 63.366226] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed. machine # [ 63.370368] systemd-homework[1258]: Everything completed. machine # [ 63.379707] 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.48 seconds) (finished: subtest: log out and deactivate homed user's home area, in 11.54 seconds) subtest: ssh as homed user sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n' sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.77 seconds) sshClient: waiting for Please enter password for user to appear on tty 1 machine # [ 65.950583] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire machine # [ 65.960587] systemd-homework[1292]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 65.970630] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 65.975423] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → inactive machine # [ 65.978351] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically. machine # [ 65.982988] systemd-homed[519]: Home test-homed-user already deactivated, no automatic deactivation needed. machine # [ 65.986608] sshd-session[1288]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error machine # [ 65.991637] sshd-session[1288]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation. machine # [ 65.996253] sshd-session[1288]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 41182 ssh2: ED25519 SHA256:41QTNPJ3LLR6YlENJ9Ixy9g5YqQRG425v3qiQSCy9d8 machine # [ 66.041654] sshd-session[1288]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 66.054400] systemd-logind[542]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'. machine # [ 66.057514] systemd[1]: Starting User Runtime Directory /run/user/60388... machine # [ 66.080431] systemd[1]: Finished User Runtime Directory /run/user/60388. machine # [ 66.086541] systemd[1]: Started Session 3 of User test-homed-user. machine # [ 66.103419] sshd-session[1288]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 66.106852] sshd-session[1288]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory machine # [ 66.123061] systemd-homed[519]: test-homed-user: changing state inactive → activating machine # [ 66.127531] systemd-homework[1297]: None of the supplied plaintext passwords unlock the user record's hashed passwords. machine # [ 66.134481] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication. machine # [ 66.136661] 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.08 seconds) sshClient: sending keys 'barfoobar\n' sshClient: (finished: sending keys 'barfoobar\n', in 0.11 seconds) machine: waiting for success: pgrep -u test-homed-user bash machine # [ 67.146706] systemd-homed[519]: test-homed-user: changing state inactive → activating machine # [ 67.188588] systemd-homework[1302]: Provided password unlocks user record. machine # [ 67.192993] systemd-homework[1302]: Successfully locked image file '/home/test-homed-user.home'. machine # [ 67.197463] systemd-homework[1302]: Backing file is fully allocated already. machine # [ 67.346543] loop1: detected capacity change from 0 to 557056 machine # [ 67.202653] systemd-homework[1302]: Setting up loopback device /dev/loop1 completed. machine # [ 68.162141] systemd-homework[1302]: Setting up LUKS device /dev/mapper/home-test-homed-user completed. machine # [ 68.188915] systemd-homework[1302]: Provided password unlocks user record. machine # [ 68.194889] systemd-homework[1302]: Probing file system completed (found btrfs). machine # [ 68.196405] systemd-homework[1302]: No fsck for file system btrfs installed, ignoring. machine # [ 68.344542] BTRFS: device label test-homed-user devid 1 transid 18 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1302) machine # [ 68.346689] BTRFS info (device dm-0): first mount of filesystem 34ab1021-4c1b-41e8-a2fb-a7907ed51083 machine # [ 68.348181] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm machine # [ 68.353030] BTRFS info (device dm-0): enabling free space tree machine # [ 68.353693] BTRFS info (device dm-0): use zstd compression, level 1 machine # [ 68.209047] systemd-homework[1302]: Mounting file system completed. machine # [ 68.210928] systemd-homework[1302]: Discovered used loopback device /dev/loop1. machine # [ 68.213199] systemd-homework[1302]: offset = 1048576, size = 285212672, image = 287309824 machine # [ 68.221857] systemd-homework[1302]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M. machine # [ 68.223885] systemd-homework[1302]: Growing of image file from 274M to 764M completed. machine # [ 68.372483] loop1: detected capacity change from 557056 to 1560576 machine # [ 68.228744] systemd-homework[1302]: Refreshing loop device size completed. machine # [ 68.242632] systemd-homework[1302]: Growing of partition completed. machine # [ 68.268230] systemd-homework[1302]: LUKS device growing completed. machine # [ 68.420924] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 782237696 machine # [ 68.276703] systemd-homework[1302]: File system resizing from 256M to 746M completed. machine # [ 68.279066] systemd-homework[1302]: Synchronized disk. machine # [ 68.279759] systemd-homework[1302]: Synchronized disk. machine # [ 68.280493] systemd-homework[1302]: Resizing completed. machine # [ 68.281247] systemd-homework[1302]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 68.282943] systemd-homework[1302]: Read embedded .identity file. machine # [ 68.303056] systemd-homework[1302]: Provided password unlocks user record. machine # [ 68.304163] systemd-homework[1302]: Reconciling user identities completed (host and header version were identical). machine # [ 68.306194] systemd-homework[1302]: Reconciling embedded user identity completed (host and embedded version were identical). machine # [ 68.307952] systemd-homework[1302]: Recursive changing of ownership not necessary, skipped. machine # [ 68.309556] systemd-homework[1302]: Synchronized disk. machine # [ 68.311804] systemd-homework[1302]: Moving to final mount point /home/test-homed-user completed. machine # [ 68.336371] systemd-homework[1302]: Activation completed. machine # [ 68.337575] systemd-homework[1302]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M. machine # [ 68.350136] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting. machine # [ 68.358181] systemd-homed[519]: test-homed-user: changing state activating → active machine # [ 68.369236] systemd[1]: Starting User Manager for UID 60388... machine # [ 68.400365] (systemd)[1342]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired. machine # [ 68.437673] (systemd)[1342]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0) machine # [ 68.443676] systemd-logind[542]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'. machine # [ 68.462279] systemd[1342]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.540459] systemd[1342]: Queued start job for default target Main User Target. machine # [ 68.542930] systemd[1342]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.545357] systemd[1342]: Created slice User Application Slice. machine # [ 68.546405] systemd[1342]: Started Daily Cleanup of User's Temporary Directories. machine # [ 68.547559] systemd[1342]: Reached target Paths. machine # [ 68.549146] systemd[1342]: Reached target Timers. machine # [ 68.550989] systemd[1342]: Starting D-Bus User Message Bus Socket... machine # [ 68.554647] systemd[1342]: Starting Create User Files and Directories... machine # [ 68.582617] systemd[1342]: Finished Create User Files and Directories. machine # [ 68.585728] systemd[1342]: Listening on D-Bus User Message Bus Socket. machine # [ 68.586885] systemd[1342]: Reached target Sockets. machine # [ 68.587773] systemd[1342]: Reached target Basic System. machine # [ 68.591309] systemd[1]: Started User Manager for UID 60388. machine # [ 68.593178] systemd[1342]: Starting Run user-specific NixOS activation... machine # [ 68.627456] systemd[1342]: Finished Run user-specific NixOS activation. machine # [ 68.628458] systemd[1342]: Reached target Main User Target. machine # [ 68.630884] systemd[1342]: Startup finished in 173ms. machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.18 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 # [ 70.571454] sshd-session[1295]: Received disconnect from 2001:db8:1::2 port 41182:11: disconnected by user machine # [ 70.576581] sshd-session[1295]: Disconnected from user test-homed-user 2001:db8:1::2 port 41182 sshClient: (finished: sending keys 'exit\n', in 0.05 seconds) (finished: subtest: ssh as homed user, in 6.50 seconds) (finished: run the VM test script, in 71.53 seconds) machine # [ 70.583778] sshd-session[1288]: pam_unix(sshd:session): session closed for user test-homed-user machine # [ 70.586907] sshd-session[1288]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used. machine # [ 70.601975] systemd[1]: session-3.scope: Deactivated successfully. machine # [ 70.608750] systemd-logind[542]: Session 3 logged out. Waiting for processes to exit. machine # [ 70.614287] systemd-logind[542]: Removed session 3. sshClient # [ 70.609713] login[696]: pam_unix(login:session): session closed for user test-normal-user sshClient # [ 70.618680] systemd[1]: getty@tty1.service: Deactivated successfully. sshClient # [ 70.631892] systemd[1]: session-1.scope: Deactivated successfully. sshClient # [ 70.635547] systemd[1]: session-1.scope: Consumed 135ms CPU time over 37.118s wall clock time, 9.4M memory peak, 12K written to disk, 22K incoming IP traffic, 21K outgoing IP traffic. sshClient # [ 70.644695] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1. sshClient # [ 70.650593] systemd-logind[534]: Session 1 logged out. Waiting for processes to exit. sshClient # [ 70.657422] systemd[1]: Started Getty on tty1. sshClient # [ 70.662194] systemd-logind[534]: Removed session 1. test script finished in 71.88s cleanup kill QemuMachine (pid 47) 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-16T02:58:14Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-16T02:58:14Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-16T02:58:14Z INFO virtiofsd] Client disconnected, shutting down kill QemuMachine (pid 48) 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-16T02:58:14Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-10-16T02:58:14Z INFO virtiofsd] Client disconnected, shutting down sshClient # [2026-10-16T02:58:14Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.36 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