vm-test-run-systemd-homed
checks.x86_64-linux.systemd-homed
· build #18
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7start all VMs8machine: starting vm9sshClient: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine # Formatting '/build/vm-state-machine/tmp.U8OfSrZlMr', fmt=raw size=107374182412machine # mke2fs 1.47.4 (6-Mar-2025)13machine: QEMU running (pid 47)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: d031f27f-8f33-476b-803b-e4013b8c74c217machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26sshClient: QEMU running (pid 48)27sshClient # Disk image does not exist, creating the virtualisation disk image...28sshClient # Formatting '/build/vm-state-sshClient/tmp.r38viMBcNU', fmt=raw size=107374182429sshClient # mke2fs 1.47.4 (6-Mar-2025)30(finished: start all VMs, in 0.32 seconds)31sshClient # Discarding device blocks: 0/262144 done32subtest: create systemd-homed user on first boot prompt33sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes34machine: waiting for unit systemd-homed.service35sshClient # Filesystem UUID: dbda01bc-e125-44ab-8f52-10f634773e2436machine: waiting for the VM to finish booting37sshClient # Superblock backups stored on blocks:38sshClient # 32768, 98304, 163840, 22937639sshClient # 40sshClient # Allocating group tables: 0/8 done41sshClient # Writing inode tables: 0/8 done42sshClient # Creating journal (8192 blocks): done43sshClient # Writing superblocks and filesystem accounting information: 0/8 done44sshClient # 45sshClient # Virtualisation disk image created.46sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)47machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)48sshClient # 49sshClient # 50machine # 51machine # 52sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0053machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0054sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)...55sshClient # 56sshClient # 57sshClient # 58sshClient # 59machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...60machine # 61machine # 62machine # 63machine # 64sshClient # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0065machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0066sshClient # Press Ctrl-B to configure iPXE (PCI 00:08.0)...67sshClient # 68sshClient # 69machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)...70machine # 71machine # 72machine # Booting from ROM...73sshClient # Booting from ROM...74machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 202675machine # [ 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/vlj94ad0g90ww17iw5fmq8hc2ndjkcsl-nixos-system-machine-test/init regInfo=/nix/store/mh20wzkf0zg1rpbik4m731fjg5xbcpxs-closure-info/registration console=ttyS0,115200n8 console=tty076machine # [ 0.000000] BIOS-provided physical RAM map:77machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable78machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved79machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved80machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable81machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved82machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved83machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved84machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved85machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved86machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved87machine # [ 0.000000] NX (Execute Disable) protection: active88machine # [ 0.000000] APIC: Static calls initialized89machine # [ 0.000000] SMBIOS 2.8 present.90machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201491machine # [ 0.000000] DMI: Memory slots populated: 1/192machine # [ 0.000000] Hypervisor detected: KVM93machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000094machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0095machine # [ 0.000000] kvm-clock: using sched offset of 440276748 cycles96machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns97machine # [ 0.000005] tsc: Detected 2400.012 MHz processor98machine # [ 0.000813] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000099machine # [ 0.000840] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs100machine # [ 0.000843] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT101machine # [ 0.002743] found SMP MP-table at [mem 0x000f5450-0x000f545f]102machine # [ 0.002754] Using GB pages for direct mapping103machine # [ 0.002845] RAMDISK: [mem 0x3e42a000-0x3ffcffff]104machine # [ 0.002853] ACPI: Early table checksum verification disabled105machine # [ 0.002855] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )106machine # [ 0.002859] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)107machine # [ 0.002863] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)108machine # [ 0.002870] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)109machine # [ 0.002872] ACPI: FACS 0x000000003FFE0000 000040110machine # [ 0.002873] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)111machine # [ 0.002875] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)112machine # [ 0.002877] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)113machine # [ 0.002878] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)114machine # [ 0.002879] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]115machine # [ 0.002880] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]116machine # [ 0.002881] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]117machine # [ 0.002881] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]118machine # [ 0.002882] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]119machine # [ 0.002882] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]120machine # [ 0.002883] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]121machine # [ 0.003097] No NUMA configuration found122machine # [ 0.003098] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]123machine # [ 0.003101] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]124machine # [ 0.005327] Zone ranges:125machine # [ 0.005328] DMA [mem 0x0000000000001000-0x0000000000ffffff]126machine # [ 0.005329] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]127machine # [ 0.005330] Normal empty128machine # [ 0.005331] Device empty129machine # [ 0.005331] Movable zone start for each node130machine # [ 0.005332] Early memory node ranges131machine # [ 0.005332] node 0: [mem 0x0000000000001000-0x000000000009efff]132machine # [ 0.005333] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]133sshClient # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 2026134machine # [ 0.005335] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]135machine # [ 0.005353] On node 0, zone DMA: 1 pages in unavailable ranges136machine # [ 0.005610] On node 0, zone DMA: 97 pages in unavailable ranges137machine # [ 0.021954] On node 0, zone DMA32: 40 pages in unavailable ranges138machine # [ 0.022400] ACPI: PM-Timer IO Port: 0x608139sshClient # [ 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/y9ipcb2wlscdx9jc4mqc42ch9l81px5m-nixos-system-sshClient-test/init regInfo=/nix/store/47qvm1xd4fdzymc02p4jhwl2z49zcpmx-closure-info/registration console=ttyS0,115200n8 console=tty0140machine # [ 0.022417] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])141sshClient # [ 0.000000] BIOS-provided physical RAM map:142machine # [ 0.022441] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23143sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable144machine # [ 0.022443] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)145sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved146machine # [ 0.022445] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)147sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved148machine # [ 0.022445] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)149sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable150machine # [ 0.022446] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)151sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved152machine # [ 0.022447] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)153sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved154machine # [ 0.022449] ACPI: Using ACPI (MADT) for SMP configuration information155sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved156machine # [ 0.022450] ACPI: HPET id: 0x8086a201 base: 0xfed00000157machine # [ 0.022454] TSC deadline timer available158sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved159machine # [ 0.022458] CPU topo: Max. logical packages: 1160sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved161machine # [ 0.022458] CPU topo: Max. logical dies: 1162machine # [ 0.022459] CPU topo: Max. dies per package: 1163sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved164machine # [ 0.022462] CPU topo: Max. threads per core: 1165sshClient # [ 0.000000] NX (Execute Disable) protection: active166machine # [ 0.022463] CPU topo: Num. cores per package: 1167sshClient # [ 0.000000] APIC: Static calls initialized168sshClient # [ 0.000000] SMBIOS 2.8 present.169machine # [ 0.022463] CPU topo: Num. threads per package: 1170machine # [ 0.022464] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs171sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014172machine # [ 0.022480] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()173sshClient # [ 0.000000] DMI: Memory slots populated: 1/1174sshClient # [ 0.000000] Hypervisor detected: KVM175machine # [ 0.022508] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]176sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000177machine # [ 0.022510] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]178sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00179sshClient # [ 0.000000] kvm-clock: using sched offset of 489090514 cycles180machine # [ 0.022511] [mem 0x40000000-0xafffffff] available for PCI devices181machine # [ 0.022512] Booting paravirtualized kernel on KVM182sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns183sshClient # [ 0.000004] tsc: Detected 2400.012 MHz processor184machine # [ 0.022515] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns185sshClient # [ 0.000811] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000186machine # [ 0.026947] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1187sshClient # [ 0.000837] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs188machine # [ 0.028962] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152189machine # [ 0.029001] kvm-guest: PV spinlocks disabled, single CPU190sshClient # [ 0.000840] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT191sshClient # [ 0.002740] found SMP MP-table at [mem 0x000f5450-0x000f545f]192sshClient # [ 0.002750] Using GB pages for direct mapping193sshClient # [ 0.002844] RAMDISK: [mem 0x3e429000-0x3ffcffff]194sshClient # [ 0.002851] ACPI: Early table checksum verification disabled195sshClient # [ 0.002854] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )196machine # [ 0.029002] 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/vlj94ad0g90ww17iw5fmq8hc2ndjkcsl-nixos-system-machine-test/init regInfo=/nix/store/mh20wzkf0zg1rpbik4m731fjg5xbcpxs-closure-info/registration console=ttyS0,115200n8 console=tty0197sshClient # [ 0.002858] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)198sshClient # [ 0.002861] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)199machine # [ 0.029091] Unknown kernel command line parameters "regInfo=/nix/store/mh20wzkf0zg1rpbik4m731fjg5xbcpxs-closure-info/registration", will be passed to user space.200machine # [ 0.029104] random: crng init done201sshClient # [ 0.002868] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)202machine # [ 0.029104] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes203sshClient # [ 0.002870] ACPI: FACS 0x000000003FFE0000 000040204machine # [ 0.029125] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)205sshClient # [ 0.002872] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)206machine # [ 0.029137] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)207sshClient # [ 0.002874] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)208machine # [ 0.029167] Fallback order for Node 0: 0209machine # [ 0.029170] Built 1 zonelists, mobility grouping on. Total pages: 262006210sshClient # [ 0.002875] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)211machine # [ 0.029171] Policy zone: DMA32212machine # [ 0.031447] mem auto-init: stack:all(zero), heap alloc:on, heap free:off213sshClient # [ 0.002877] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)214machine # [ 0.033744] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1215sshClient # [ 0.002878] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]216machine # [ 0.035960] allocated 2097152 bytes of page_ext217sshClient # [ 0.002879] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]218machine # [ 0.045562] ftrace: allocating 48733 entries in 192 pages219machine # [ 0.045564] ftrace: allocated 192 pages with 2 groups220sshClient # [ 0.002880] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]221machine # [ 0.046339] Dynamic Preempt: lazy222sshClient # [ 0.002880] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]223machine # [ 0.046518] rcu: Preemptible hierarchical RCU implementation.224machine # [ 0.046519] rcu: RCU event tracing is enabled.225sshClient # [ 0.002881] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]226machine # [ 0.046519] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.227sshClient # [ 0.002881] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]228machine # [ 0.046521] Trampoline variant of Tasks RCU enabled.229sshClient # [ 0.002881] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]230machine # [ 0.046521] Rude variant of Tasks RCU enabled.231sshClient # [ 0.003103] No NUMA configuration found232machine # [ 0.046521] Tracing variant of Tasks RCU enabled.233sshClient # [ 0.003104] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]234machine # [ 0.046522] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.235sshClient # [ 0.003107] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]236sshClient # [ 0.005343] Zone ranges:237machine # [ 0.046523] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1238sshClient # [ 0.005344] DMA [mem 0x0000000000001000-0x0000000000ffffff]239machine # [ 0.046541] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.240sshClient # [ 0.005345] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]241sshClient # [ 0.005346] Normal empty242sshClient # [ 0.005347] Device empty243machine # [ 0.046542] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.244sshClient # [ 0.005348] Movable zone start for each node245sshClient # [ 0.005348] Early memory node ranges246machine # [ 0.046543] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.247sshClient # [ 0.005349] node 0: [mem 0x0000000000001000-0x000000000009efff]248machine # [ 0.050829] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16249sshClient # [ 0.005350] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]250machine # [ 0.051104] rcu: srcu_init: Setting srcu_struct sizes based on contention.251sshClient # [ 0.005351] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]252machine # [ 0.051109] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns253sshClient # [ 0.005369] On node 0, zone DMA: 1 pages in unavailable ranges254sshClient # [ 0.005612] On node 0, zone DMA: 97 pages in unavailable ranges255machine # [ 0.051210] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)256sshClient # [ 0.021986] On node 0, zone DMA32: 40 pages in unavailable ranges257machine # [ 0.054706] Console: colour VGA+ 80x25258sshClient # [ 0.022437] ACPI: PM-Timer IO Port: 0x608259machine # [ 0.054709] printk: legacy console [tty0] enabled260sshClient # [ 0.022446] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])261machine # [ 0.084174] printk: legacy console [ttyS0] enabled262machine # [ 0.188771] ACPI: Core revision 20250807263sshClient # [ 0.022470] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23264sshClient # [ 0.022472] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)265sshClient # [ 0.022474] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)266machine # [ 0.189709] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns267sshClient # [ 0.022474] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)268machine # [ 0.191255] APIC: Switch to symmetric I/O mode setup269sshClient # [ 0.022475] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)270machine # [ 0.192228] x2apic enabled271sshClient # [ 0.022476] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)272machine # [ 0.193000] APIC: Switched APIC routing to: physical x2apic273sshClient # [ 0.022478] ACPI: Using ACPI (MADT) for SMP configuration information274sshClient # [ 0.022479] ACPI: HPET id: 0x8086a201 base: 0xfed00000275sshClient # [ 0.022482] TSC deadline timer available276machine # [ 0.194815] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1277sshClient # [ 0.022486] CPU topo: Max. logical packages: 1278sshClient # [ 0.022487] CPU topo: Max. logical dies: 1279sshClient # [ 0.022487] CPU topo: Max. dies per package: 1280machine # [ 0.195851] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns281sshClient # [ 0.022491] CPU topo: Max. threads per core: 1282sshClient # [ 0.022491] CPU topo: Num. cores per package: 1283machine # [ 0.197525] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)284sshClient # [ 0.022492] CPU topo: Num. threads per package: 1285sshClient # [ 0.022492] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs286machine # [ 0.198607] x86/cpu: User Mode Instruction Prevention (UMIP) activated287sshClient # [ 0.022506] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()288machine # [ 0.199636] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127289sshClient # [ 0.022534] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]290machine # [ 0.201220] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0291sshClient # [ 0.022536] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]292sshClient # [ 0.022537] [mem 0x40000000-0xafffffff] available for PCI devices293machine # [ 0.201526] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto294sshClient # [ 0.022539] Booting paravirtualized kernel on KVM295machine # [ 0.203523] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl296sshClient # [ 0.022541] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns297machine # [ 0.204522] Transient Scheduler Attacks: Vulnerable: No microcode298sshClient # [ 0.027199] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1299machine # [ 0.206318] Spectre V2 : Mitigation: Enhanced / Automatic IBRS300sshClient # [ 0.029223] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152301sshClient # [ 0.029260] kvm-guest: PV spinlocks disabled, single CPU302machine # [ 0.207204] Speculative Return Stack Overflow: Mitigation: Safe RET303sshClient # [ 0.029262] 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/y9ipcb2wlscdx9jc4mqc42ch9l81px5m-nixos-system-sshClient-test/init regInfo=/nix/store/47qvm1xd4fdzymc02p4jhwl2z49zcpmx-closure-info/registration console=ttyS0,115200n8 console=tty0304machine # [ 0.208265] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization305machine # [ 0.209529] Spectre V2 : Enabling IBPB for BPF306sshClient # [ 0.029349] Unknown kernel command line parameters "regInfo=/nix/store/47qvm1xd4fdzymc02p4jhwl2z49zcpmx-closure-info/registration", will be passed to user space.307sshClient # [ 0.029362] random: crng init done308machine # [ 0.210523] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier309sshClient # [ 0.029362] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes310machine # [ 0.211523] active return thunk: srso_alias_return_thunk311sshClient # [ 0.029383] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)312machine # [ 0.213207] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'313sshClient # [ 0.029395] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)314machine # [ 0.214377] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'315sshClient # [ 0.029423] Fallback order for Node 0: 0316sshClient # [ 0.029426] Built 1 zonelists, mobility grouping on. Total pages: 262006317machine # [ 0.215305] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'318sshClient # [ 0.029427] Policy zone: DMA32319machine # [ 0.216340] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'320sshClient # [ 0.031731] mem auto-init: stack:all(zero), heap alloc:on, heap free:off321sshClient # [ 0.034014] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1322machine # [ 0.217327] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'323sshClient # [ 0.036248] allocated 2097152 bytes of page_ext324sshClient # [ 0.045752] ftrace: allocating 48733 entries in 192 pages325machine # [ 0.218522] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'326sshClient # [ 0.045754] ftrace: allocated 192 pages with 2 groups327sshClient # [ 0.046537] Dynamic Preempt: lazy328machine # [ 0.219522] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'329sshClient # [ 0.046688] rcu: Preemptible hierarchical RCU implementation.330machine # [ 0.220523] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256331sshClient # [ 0.046689] rcu: RCU event tracing is enabled.332sshClient # [ 0.046690] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.333machine # [ 0.221522] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64334sshClient # [ 0.046691] Trampoline variant of Tasks RCU enabled.335sshClient # [ 0.046691] Rude variant of Tasks RCU enabled.336machine # [ 0.222522] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512337sshClient # [ 0.046691] Tracing variant of Tasks RCU enabled.338machine # [ 0.223522] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024339sshClient # [ 0.046692] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.340machine # [ 0.224522] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8341sshClient # [ 0.046693] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1342sshClient # [ 0.046713] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.343machine # [ 0.225522] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.344sshClient # [ 0.046714] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.345sshClient # [ 0.046715] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.346sshClient # [ 0.050986] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16347sshClient # [ 0.051227] rcu: srcu_init: Setting srcu_struct sizes based on contention.348sshClient # [ 0.051232] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns349sshClient # [ 0.051334] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)350sshClient # [ 0.054824] Console: colour VGA+ 80x25351sshClient # [ 0.054826] printk: legacy console [tty0] enabled352sshClient # [ 0.084531] printk: legacy console [ttyS0] enabled353sshClient # [ 0.187225] ACPI: Core revision 20250807354sshClient # [ 0.188122] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns355sshClient # [ 0.189755] APIC: Switch to symmetric I/O mode setup356sshClient # [ 0.190774] x2apic enabled357sshClient # [ 0.191538] APIC: Switched APIC routing to: physical x2apic358sshClient # [ 0.193424] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1359sshClient # [ 0.194487] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns360sshClient # [ 0.196248] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)361sshClient # [ 0.198290] x86/cpu: User Mode Instruction Prevention (UMIP) activated362sshClient # [ 0.199369] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127363sshClient # [ 0.200246] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0364sshClient # [ 0.201249] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto365sshClient # [ 0.202246] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl366sshClient # [ 0.203246] Transient Scheduler Attacks: Vulnerable: No microcode367sshClient # [ 0.204245] Spectre V2 : Mitigation: Enhanced / Automatic IBRS368sshClient # [ 0.205245] Speculative Return Stack Overflow: Mitigation: Safe RET369sshClient # [ 0.206245] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization370machine # [ 0.259181] Freeing SMP alternatives memory: 44K371sshClient # [ 0.208252] Spectre V2 : Enabling IBPB for BPF372machine # [ 0.259525] pid_max: default: 32768 minimum: 301373machine # [ 0.260606] LSM: initializing lsm=capability,landlock,yama,bpf,ima374sshClient # [ 0.209246] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier375machine # [ 0.261626] landlock: Up and running.376sshClient # [ 0.210246] active return thunk: srso_alias_return_thunk377machine # [ 0.262523] Yama: becoming mindful.378machine # [ 0.263326] LSM support for eBPF active379sshClient # [ 0.211266] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'380sshClient # [ 0.212245] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'381machine # [ 0.264079] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)382sshClient # [ 0.214245] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'383machine # [ 0.264540] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)384sshClient # [ 0.215245] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'385sshClient # [ 0.216245] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'386machine # [ 0.267613] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)387sshClient # [ 0.217245] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'388machine # [ 0.269043] Performance Events: Fam17h+ core perfctr, AMD PMU driver.389sshClient # [ 0.218245] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'390machine # [ 0.269531] ... version: 2391sshClient # [ 0.219246] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256392machine # [ 0.270213] ... bit width: 48393sshClient # [ 0.220245] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64394machine # [ 0.270525] ... generic counters: 6395sshClient # [ 0.221245] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512396machine # [ 0.271258] ... generic bitmap: 000000000000003f397machine # [ 0.271524] ... fixed-purpose counters: 0398sshClient # [ 0.222245] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024399machine # [ 0.272240] ... fixed-purpose bitmap: 0000000000000000400sshClient # [ 0.223245] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8401machine # [ 0.272524] ... value mask: 0000ffffffffffff402sshClient # [ 0.224245] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.403machine # [ 0.273411] ... max period: 00007fffffffffff404machine # [ 0.274184] ... global_ctrl mask: 000000000000003f405machine # [ 0.274620] signal: max sigframe size: 3376406machine # [ 0.275450] rcu: Hierarchical SRCU implementation.407machine # [ 0.276179] rcu: Max phase no-delay instances is 400.408machine # [ 0.280980] smp: Bringing up secondary CPUs ...409machine # [ 0.281538] smp: Brought up 1 node, 1 CPU410machine # [ 0.282264] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)411machine # [ 0.282668] Memory: 941772K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 98836K reserved, 0K cma-reserved)412machine # [ 0.283728] devtmpfs: initialized413machine # [ 0.284510] x86/mm: Memory block size: 128MB414machine # [ 0.286092] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)415machine # [ 0.286549] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).416machine # [ 0.287605] pinctrl core: initialized pinctrl subsystem417machine # [ 0.288722] PM: RTC time: 02:46:18, date: 2026-09-02418machine # [ 0.292044] NET: Registered PF_NETLINK/PF_ROUTE protocol family419machine # [ 0.292884] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations420machine # [ 0.293540] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations421machine # [ 0.294655] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations422machine # [ 0.295534] audit: initializing netlink subsys (disabled)423machine # [ 0.296755] thermal_sys: Registered thermal governor 'fair_share'424machine # [ 0.296757] thermal_sys: Registered thermal governor 'bang_bang'425machine # [ 0.297526] thermal_sys: Registered thermal governor 'step_wise'426sshClient # [ 0.258787] Freeing SMP alternatives memory: 44K427sshClient # [ 0.259248] pid_max: default: 32768 minimum: 301428machine # [ 0.298528] audit: type=2000 audit(1788317178.762:1): state=initialized audit_enabled=0 res=1429sshClient # [ 0.260327] LSM: initializing lsm=capability,landlock,yama,bpf,ima430machine # [ 0.300526] thermal_sys: Registered thermal governor 'user_space'431sshClient # [ 0.261336] landlock: Up and running.432machine # [ 0.300528] thermal_sys: Registered thermal governor 'power_allocator'433sshClient # [ 0.261973] Yama: becoming mindful.434machine # [ 0.301464] cpuidle: using governor menu435sshClient # [ 0.262917] LSM support for eBPF active436machine # [ 0.303106] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5437sshClient # [ 0.263336] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)438sshClient # [ 0.264265] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)439machine # [ 0.303749] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]440machine # [ 0.304527] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry441machine # [ 0.305536] PCI: Using configuration type 1 for base access442sshClient # [ 0.267312] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)443machine # [ 0.306654] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.444sshClient # [ 0.268764] Performance Events: Fam17h+ core perfctr, AMD PMU driver.445sshClient # [ 0.269254] ... version: 2446sshClient # [ 0.269998] ... bit width: 48447sshClient # [ 0.270248] ... generic counters: 6448sshClient # [ 0.270993] ... generic bitmap: 000000000000003f449sshClient # [ 0.271247] ... fixed-purpose counters: 0450sshClient # [ 0.271994] ... fixed-purpose bitmap: 0000000000000000451machine # [ 0.311906] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages452sshClient # [ 0.272247] ... value mask: 0000ffffffffffff453machine # [ 0.312533] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page454sshClient # [ 0.273128] ... max period: 00007fffffffffff455machine # [ 0.313526] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages456sshClient # [ 0.273924] ... global_ctrl mask: 000000000000003f457sshClient # [ 0.274355] signal: max sigframe size: 3376458sshClient # [ 0.275162] rcu: Hierarchical SRCU implementation.459sshClient # [ 0.275870] rcu: Max phase no-delay instances is 400.460machine # [ 0.320526] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page461sshClient # [ 0.280768] smp: Bringing up secondary CPUs ...462sshClient # [ 0.281256] smp: Brought up 1 node, 1 CPU463sshClient # [ 0.281950] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)464sshClient # [ 0.282440] Memory: 941812K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 98840K reserved, 0K cma-reserved)465sshClient # [ 0.283442] devtmpfs: initialized466sshClient # [ 0.284285] x86/mm: Memory block size: 128MB467machine # [ 0.327869] ACPI: Added _OSI(Module Device)468machine # [ 0.328527] ACPI: Added _OSI(Processor Device)469machine # [ 0.329311] ACPI: Added _OSI(Processor Aggregator Device)470sshClient # [ 0.285981] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)471sshClient # [ 0.287183] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).472sshClient # [ 0.288338] pinctrl core: initialized pinctrl subsystem473sshClient # [ 0.289484] PM: RTC time: 02:46:18, date: 2026-09-02474sshClient # [ 0.292802] NET: Registered PF_NETLINK/PF_ROUTE protocol family475sshClient # [ 0.293579] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations476machine # [ 0.338548] ACPI: 1 ACPI AML tables successfully acquired and loaded477sshClient # [ 0.294270] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations478sshClient # [ 0.295385] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations479sshClient # [ 0.296256] audit: initializing netlink subsys (disabled)480sshClient # [ 0.297408] thermal_sys: Registered thermal governor 'fair_share'481machine # [ 0.342941] ACPI: Interpreter enabled482sshClient # [ 0.297410] thermal_sys: Registered thermal governor 'bang_bang'483machine # [ 0.343547] ACPI: PM: (supports S0 S3 S4 S5)484machine # [ 0.344300] ACPI: Using IOAPIC for interrupt routing485sshClient # [ 0.298249] thermal_sys: Registered thermal governor 'step_wise'486sshClient # [ 0.299197] thermal_sys: Registered thermal governor 'user_space'487sshClient # [ 0.299982] audit: type=2000 audit(1788317178.816:1): state=initialized audit_enabled=0 res=1488sshClient # [ 0.301251] thermal_sys: Registered thermal governor 'power_allocator'489machine # [ 0.346605] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug490sshClient # [ 0.301265] cpuidle: using governor menu491machine # [ 0.347526] PCI: Using E820 reservations for host bridge windows492sshClient # [ 0.303479] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5493sshClient # [ 0.304473] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]494machine # [ 0.350657] ACPI: Enabled 2 GPEs in block 00 to 3F495sshClient # [ 0.305251] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry496sshClient # [ 0.306261] PCI: Using configuration type 1 for base access497sshClient # [ 0.307400] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.498machine # [ 0.358801] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])499sshClient # [ 0.312473] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages500machine # [ 0.359531] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]501sshClient # [ 0.313249] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page502machine # [ 0.360604] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]503machine # [ 0.361646] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]504machine # [ 0.363401] PCI host bridge to bus 0000:00505sshClient # [ 0.318249] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages506machine # [ 0.364099] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]507sshClient # [ 0.319247] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page508machine # [ 0.364526] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]509machine # [ 0.365526] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]510machine # [ 0.366525] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]511machine # [ 0.367525] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]512machine # [ 0.368526] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]513machine # [ 0.369531] pci_bus 0000:00: root bus resource [bus 00-ff]514machine # [ 0.370577] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint515machine # [ 0.372031] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint516sshClient # [ 0.329619] ACPI: Added _OSI(Module Device)517sshClient # [ 0.330250] ACPI: Added _OSI(Processor Device)518sshClient # [ 0.330995] ACPI: Added _OSI(Processor Aggregator Device)519machine # [ 0.374549] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]520machine # [ 0.375536] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]521machine # [ 0.376546] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]522machine # [ 0.377687] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]523sshClient # [ 0.339995] ACPI: 1 ACPI AML tables successfully acquired and loaded524machine # [ 0.379229] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint525sshClient # [ 0.343650] ACPI: Interpreter enabled526machine # [ 0.382554] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]527sshClient # [ 0.344263] ACPI: PM: (supports S0 S3 S4 S5)528machine # [ 0.383419] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]529sshClient # [ 0.344976] ACPI: Using IOAPIC for interrupt routing530machine # [ 0.384305] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]531sshClient # [ 0.345301] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug532machine # [ 0.385391] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]533sshClient # [ 0.346248] PCI: Using E820 reservations for host bridge windows534machine # [ 0.386851] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint535sshClient # [ 0.349390] ACPI: Enabled 2 GPEs in block 00 to 3F536machine # [ 0.389604] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]537machine # [ 0.390532] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]538machine # [ 0.391547] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]539machine # [ 0.393094] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint540machine # [ 0.394549] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]541sshClient # [ 0.358138] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])542machine # [ 0.395421] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]543sshClient # [ 0.359018] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]544machine # [ 0.396286] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]545sshClient # [ 0.360851] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]546machine # [ 0.398474] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint547sshClient # [ 0.361370] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]548sshClient # [ 0.362615] PCI host bridge to bus 0000:00549machine # [ 0.400532] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]550sshClient # [ 0.363252] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]551machine # [ 0.401384] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]552sshClient # [ 0.364248] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]553machine # [ 0.402315] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]554sshClient # [ 0.365248] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]555sshClient # [ 0.366248] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]556machine # [ 0.403964] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint557sshClient # [ 0.367248] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]558sshClient # [ 0.368248] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]559machine # [ 0.405551] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]560sshClient # [ 0.369248] pci_bus 0000:00: root bus resource [bus 00-ff]561machine # [ 0.406549] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]562sshClient # [ 0.370303] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint563machine # [ 0.407512] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]564sshClient # [ 0.371714] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint565machine # [ 0.408928] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint566machine # [ 0.410554] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]567machine # [ 0.411473] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]568machine # [ 0.412335] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]569sshClient # [ 0.374298] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]570machine # [ 0.413978] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint571sshClient # [ 0.375324] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]572sshClient # [ 0.376309] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]573machine # [ 0.415540] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]574machine # [ 0.416391] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]575sshClient # [ 0.377549] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]576machine # [ 0.417300] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]577machine # [ 0.418412] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]578sshClient # [ 0.379163] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint579machine # [ 0.419840] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint580sshClient # [ 0.381283] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]581machine # [ 0.421558] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]582sshClient # [ 0.382184] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]583sshClient # [ 0.383026] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]584machine # [ 0.422547] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]585sshClient # [ 0.384125] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]586machine # [ 0.424088] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint587sshClient # [ 0.385612] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint588machine # [ 0.425533] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]589machine # [ 0.426436] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]590sshClient # [ 0.388044] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]591machine # [ 0.427330] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]592sshClient # [ 0.388909] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]593sshClient # [ 0.389292] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]594machine # [ 0.428944] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint595sshClient # [ 0.390818] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint596machine # [ 0.430533] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]597machine # [ 0.431532] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]598machine # [ 0.432546] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]599sshClient # [ 0.393284] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]600sshClient # [ 0.394227] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]601machine # [ 0.434112] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint602sshClient # [ 0.395127] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]603machine # [ 0.435088] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]604sshClient # [ 0.396721] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint605machine # [ 0.435776] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint606machine # [ 0.437062] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]607sshClient # [ 0.398278] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]608sshClient # [ 0.399185] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]609sshClient # [ 0.400060] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]610sshClient # [ 0.401719] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint611sshClient # [ 0.403255] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]612sshClient # [ 0.404108] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]613sshClient # [ 0.405026] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]614sshClient # [ 0.406694] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint615machine # [ 0.437715] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint616sshClient # [ 0.408282] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]617sshClient # [ 0.409159] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]618machine # [ 0.441108] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]619sshClient # [ 0.410298] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]620machine # [ 0.441786] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint621sshClient # [ 0.411843] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint622machine # [ 0.443430] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]623sshClient # [ 0.413255] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]624machine # [ 0.444512] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint625sshClient # [ 0.414164] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]626sshClient # [ 0.415057] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]627machine # [ 0.445817] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO628sshClient # [ 0.416130] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]629machine # [ 0.446774] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint630sshClient # [ 0.417586] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint631machine # [ 0.449014] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]632sshClient # [ 0.419094] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]633machine # [ 0.449532] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]634sshClient # [ 0.419996] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]635machine # [ 0.450797] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint636sshClient # [ 0.420823] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint637machine # [ 0.452292] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]638sshClient # [ 0.422290] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]639sshClient # [ 0.423210] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]640machine # [ 0.455453] ACPI: PCI: Interrupt link LNKA configured for IRQ 10641sshClient # [ 0.424058] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]642machine # [ 0.456423] ACPI: PCI: Interrupt link LNKB configured for IRQ 10643machine # [ 0.457626] ACPI: PCI: Interrupt link LNKC configured for IRQ 11644sshClient # [ 0.426207] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint645machine # [ 0.458624] ACPI: PCI: Interrupt link LNKD configured for IRQ 11646sshClient # [ 0.428283] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]647machine # [ 0.459621] ACPI: PCI: Interrupt link LNKE configured for IRQ 10648sshClient # [ 0.429106] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]649machine # [ 0.460619] ACPI: PCI: Interrupt link LNKF configured for IRQ 10650sshClient # [ 0.430046] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]651machine # [ 0.461622] ACPI: PCI: Interrupt link LNKG configured for IRQ 11652machine # [ 0.462626] ACPI: PCI: Interrupt link LNKH configured for IRQ 11653sshClient # [ 0.431686] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint654machine # [ 0.463560] ACPI: PCI: Interrupt link GSIA configured for IRQ 16655machine # [ 0.464540] ACPI: PCI: Interrupt link GSIB configured for IRQ 17656sshClient # [ 0.432898] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]657machine # [ 0.465538] ACPI: PCI: Interrupt link GSIC configured for IRQ 18658machine # [ 0.466536] ACPI: PCI: Interrupt link GSID configured for IRQ 19659sshClient # [ 0.433455] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint660machine # [ 0.467540] ACPI: PCI: Interrupt link GSIE configured for IRQ 20661sshClient # [ 0.434788] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]662machine # [ 0.468538] ACPI: PCI: Interrupt link GSIF configured for IRQ 21663machine # [ 0.469525] ACPI: PCI: Interrupt link GSIG configured for IRQ 22664machine # [ 0.470539] ACPI: PCI: Interrupt link GSIH configured for IRQ 23665machine # [ 0.472596] iommu: Default domain type: Translated666machine # [ 0.473452] iommu: DMA domain TLB invalidation policy: lazy mode667machine # [ 0.474717] ACPI: bus type USB registered668machine # [ 0.475514] usbcore: registered new interface driver usbfs669machine # [ 0.476272] usbcore: registered new interface driver hub670machine # [ 0.476541] usbcore: registered new device driver usb671machine # [ 0.478212] NetLabel: Initializing672machine # [ 0.478531] NetLabel: domain hash size = 128673machine # [ 0.479332] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO674sshClient # [ 0.435453] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint675machine # [ 0.480292] NetLabel: unlabeled traffic allowed by default676sshClient # [ 0.437806] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]677machine # [ 0.480534] PCI: Using ACPI for IRQ routing678sshClient # [ 0.438479] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint679sshClient # [ 0.439814] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]680sshClient # [ 0.440504] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint681sshClient # [ 0.441538] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO682sshClient # [ 0.442531] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint683sshClient # [ 0.444153] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]684sshClient # [ 0.444933] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]685sshClient # [ 0.445570] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint686sshClient # [ 0.446826] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]687sshClient # [ 0.450223] ACPI: PCI: Interrupt link LNKA configured for IRQ 10688sshClient # [ 0.451133] ACPI: PCI: Interrupt link LNKB configured for IRQ 10689sshClient # [ 0.452149] ACPI: PCI: Interrupt link LNKC configured for IRQ 11690sshClient # [ 0.453167] ACPI: PCI: Interrupt link LNKD configured for IRQ 11691sshClient # [ 0.454174] ACPI: PCI: Interrupt link LNKE configured for IRQ 10692sshClient # [ 0.455121] ACPI: PCI: Interrupt link LNKF configured for IRQ 10693sshClient # [ 0.456128] ACPI: PCI: Interrupt link LNKG configured for IRQ 11694sshClient # [ 0.457177] ACPI: PCI: Interrupt link LNKH configured for IRQ 11695sshClient # [ 0.458099] ACPI: PCI: Interrupt link GSIA configured for IRQ 16696sshClient # [ 0.459061] ACPI: PCI: Interrupt link GSIB configured for IRQ 17697sshClient # [ 0.460046] ACPI: PCI: Interrupt link GSIC configured for IRQ 18698sshClient # [ 0.461068] ACPI: PCI: Interrupt link GSID configured for IRQ 19699sshClient # [ 0.462060] ACPI: PCI: Interrupt link GSIE configured for IRQ 20700sshClient # [ 0.463040] ACPI: PCI: Interrupt link GSIF configured for IRQ 21701sshClient # [ 0.464055] ACPI: PCI: Interrupt link GSIG configured for IRQ 22702sshClient # [ 0.465049] ACPI: PCI: Interrupt link GSIH configured for IRQ 23703sshClient # [ 0.467072] iommu: Default domain type: Translated704sshClient # [ 0.467937] iommu: DMA domain TLB invalidation policy: lazy mode705sshClient # [ 0.468504] ACPI: bus type USB registered706sshClient # [ 0.469278] usbcore: registered new interface driver usbfs707sshClient # [ 0.470254] usbcore: registered new interface driver hub708sshClient # [ 0.471190] usbcore: registered new device driver usb709machine # [ 0.524521] pci 0000:00:01.0: vgaarb: setting as boot VGA device710sshClient # [ 0.472797] NetLabel: Initializing711machine # [ 0.524521] pci 0000:00:01.0: vgaarb: bridge control possible712sshClient # [ 0.473706] NetLabel: domain hash size = 128713sshClient # [ 0.474248] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO714machine # [ 0.524521] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none715machine # [ 0.524529] vgaarb: loaded716sshClient # [ 0.475188] NetLabel: unlabeled traffic allowed by default717sshClient # [ 0.475957] PCI: Using ACPI for IRQ routing718machine # [ 0.525220] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0719machine # [ 0.526195] hpet0: 3 comparators, 64-bit 100.000000 MHz counter720machine # [ 0.529620] clocksource: Switched to clocksource kvm-clock721machine # [ 0.531304] VFS: Disk quotas dquot_6.6.0722machine # [ 0.533746] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)723machine # [ 0.535153] pnp: PnP ACPI init724machine # [ 0.535985] ACPI: IRQ 4 override to edge(!), high(!)725machine # [ 0.537047] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved726machine # [ 0.538695] pnp: PnP ACPI: found 6 devices727machine # [ 0.546339] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns728machine # [ 0.547894] clocksource: Switched to clocksource acpi_pm729machine # [ 0.548924] NET: Registered PF_INET protocol family730machine # [ 0.549995] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)731machine # [ 0.566280] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)732sshClient # [ 0.519907] pci 0000:00:01.0: vgaarb: setting as boot VGA device733machine # [ 0.567905] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)734sshClient # [ 0.520244] pci 0000:00:01.0: vgaarb: bridge control possible735sshClient # [ 0.520244] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none736machine # [ 0.569264] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)737sshClient # [ 0.520252] vgaarb: loaded738machine # [ 0.570690] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)739sshClient # [ 0.520999] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0740machine # [ 0.571975] TCP: Hash tables configured (established 8192 bind 8192)741sshClient # [ 0.521250] hpet0: 3 comparators, 64-bit 100.000000 MHz counter742machine # [ 0.573087] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)743machine # [ 0.574471] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)744machine # [ 0.575618] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)745sshClient # [ 0.525340] clocksource: Switched to clocksource kvm-clock746machine # [ 0.576837] NET: Registered PF_UNIX/PF_LOCAL protocol family747machine # [ 0.577809] NET: Registered PF_XDP protocol family748machine # [ 0.578684] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]749sshClient # [ 0.528705] VFS: Disk quotas dquot_6.6.0750machine # [ 0.579768] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]751sshClient # [ 0.529417] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)752machine # [ 0.580789] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]753sshClient # [ 0.530781] pnp: PnP ACPI init754machine # [ 0.581918] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]755sshClient # [ 0.531568] ACPI: IRQ 4 override to edge(!), high(!)756machine # [ 0.583029] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]757sshClient # [ 0.532584] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved758machine # [ 0.584141] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]759sshClient # [ 0.534167] pnp: PnP ACPI: found 6 devices760machine # [ 0.586218] ACPI: \_SB_.GSIA: Enabled at IRQ 16761machine # [ 0.588737] ACPI: \_SB_.GSIB: Enabled at IRQ 17762machine # [ 0.590616] ACPI: \_SB_.GSIC: Enabled at IRQ 18763machine # [ 0.592545] ACPI: \_SB_.GSID: Enabled at IRQ 19764sshClient # [ 0.541738] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns765machine # [ 0.594177] PCI: CLS 0 bytes, default 64766sshClient # [ 0.543211] clocksource: Switched to clocksource acpi_pm767sshClient # [ 0.544161] NET: Registered PF_INET protocol family768machine # [ 0.595049] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns769machine # [ 0.596764] Trying to unpack rootfs image as initramfs...770sshClient # [ 0.545292] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)771sshClient # [ 0.561702] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)772sshClient # [ 0.563265] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)773sshClient # [ 0.564604] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)774sshClient # [ 0.565929] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)775sshClient # [ 0.567242] TCP: Hash tables configured (established 8192 bind 8192)776sshClient # [ 0.568364] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)777sshClient # [ 0.569715] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)778sshClient # [ 0.570853] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)779sshClient # [ 0.572168] NET: Registered PF_UNIX/PF_LOCAL protocol family780sshClient # [ 0.573231] NET: Registered PF_XDP protocol family781sshClient # [ 0.574112] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]782sshClient # [ 0.575174] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]783sshClient # [ 0.576206] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]784sshClient # [ 0.577336] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]785sshClient # [ 0.578517] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]786sshClient # [ 0.579672] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]787sshClient # [ 0.581423] ACPI: \_SB_.GSIA: Enabled at IRQ 16788sshClient # [ 0.583918] ACPI: \_SB_.GSIB: Enabled at IRQ 17789sshClient # [ 0.585913] ACPI: \_SB_.GSIC: Enabled at IRQ 18790sshClient # [ 0.587885] ACPI: \_SB_.GSID: Enabled at IRQ 19791sshClient # [ 0.589541] PCI: CLS 0 bytes, default 64792machine # [ 0.641258] Initialise system trusted keyrings793sshClient # [ 0.590440] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns794sshClient # [ 0.592232] Trying to unpack rootfs image as initramfs...795machine # [ 0.643482] workingset: timestamp_bits=40 max_order=18 bucket_order=0796machine # [ 0.664304] Key type asymmetric registered797machine # [ 0.667437] Asymmetric key parser 'x509' registered798machine # [ 0.668296] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)799machine # [ 0.671608] io scheduler mq-deadline registered800machine # [ 0.672401] io scheduler kyber registered801machine # [ 0.676470] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled802machine # [ 0.677801] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A803machine # [ 0.683273] Linux agpgart interface v0.103804machine # [ 0.684106] ACPI: bus type drm_connector registered805sshClient # [ 0.636153] Initialise system trusted keyrings806machine # [ 0.688584] usbcore: registered new interface driver usbserial_generic807machine # [ 0.689693] usbserial: USB Serial support registered for generic808sshClient # [ 0.639081] workingset: timestamp_bits=40 max_order=18 bucket_order=0809machine # [ 0.693443] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.810machine # [ 0.693443] Please enable it if your BIOS has the CPPC option.811machine # [ 0.695750] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled812machine # [ 0.699564] drop_monitor: Initializing network drop monitor service813machine # [ 0.700784] NET: Registered PF_INET6 protocol family814machine # [ 0.703912] Segment Routing with IPv6815machine # [ 0.706463] In-situ OAM (IOAM) with IPv6816machine # [ 0.707520] IPI shorthand broadcast: enabled817sshClient # [ 0.660279] Key type asymmetric registered818sshClient # [ 0.663038] Asymmetric key parser 'x509' registered819sshClient # [ 0.663915] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)820machine # [ 0.715918] sched_clock: Marking stable (573014273, 142412388)->(786961535, -71534874)821sshClient # [ 0.667175] io scheduler mq-deadline registered822sshClient # [ 0.667974] io scheduler kyber registered823machine # [ 0.721699] registered taskstats version 1824sshClient # [ 0.670592] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled825machine # [ 0.722688] Loading compiled-in X.509 certificates826sshClient # [ 0.671937] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A827sshClient # [ 0.677851] Linux agpgart interface v0.103828sshClient # [ 0.678674] ACPI: bus type drm_connector registered829sshClient # [ 0.683508] usbcore: registered new interface driver usbserial_generic830sshClient # [ 0.684619] usbserial: USB Serial support registered for generic831machine # [ 0.739145] Demotion targets for Node 0: null832sshClient # [ 0.688042] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.833sshClient # [ 0.688042] Please enable it if your BIOS has the CPPC option.834machine # [ 0.741489] Key type .fscrypt registered835sshClient # [ 0.690291] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled836machine # [ 0.742160] Key type fscrypt-provisioning registered837machine # [ 0.743118] ima: No TPM chip found, activating TPM-bypass!838sshClient # [ 0.694165] drop_monitor: Initializing network drop monitor service839sshClient # [ 0.695376] NET: Registered PF_INET6 protocol family840machine # [ 0.747451] ima: Allocated hash algorithm: sha1841machine # [ 0.748358] ima: No architecture policies found842sshClient # [ 0.698143] Segment Routing with IPv6843sshClient # [ 0.698874] In-situ OAM (IOAM) with IPv6844machine # [ 0.750440] PM: Magic number: 10:612:762845machine # [ 0.752108] RAS: Correctable Errors collector initialized.846sshClient # [ 0.702317] IPI shorthand broadcast: enabled847sshClient # [ 0.708613] sched_clock: Marking stable (568015199, 140012424)->(780420527, -72392904)848machine # [ 0.761116] clk: Disabling unused clocks849sshClient # [ 0.714222] registered taskstats version 1850machine # [ 0.765451] PM: genpd: Disabling unused power domains851sshClient # [ 0.715179] Loading compiled-in X.509 certificates852sshClient # [ 0.734042] Demotion targets for Node 0: null853sshClient # [ 0.734998] Key type .fscrypt registered854sshClient # [ 0.735728] Key type fscrypt-provisioning registered855sshClient # [ 0.736740] ima: No TPM chip found, activating TPM-bypass!856sshClient # [ 0.741048] ima: Allocated hash algorithm: sha1857sshClient # [ 0.741872] ima: No architecture policies found858sshClient # [ 0.744045] PM: Magic number: 10:612:762859sshClient # [ 0.745670] RAS: Correctable Errors collector initialized.860sshClient # [ 0.755816] clk: Disabling unused clocks861sshClient # [ 0.758047] PM: genpd: Disabling unused power domains862machine # [ 0.916509] Freeing initrd memory: 28312K863machine # [ 0.919592] Freeing unused decrypted memory: 2028K864machine # [ 0.922116] Freeing unused kernel image (initmem) memory: 3644K865machine # [ 0.923217] Write protecting the kernel read-only data: 32768k866machine # [ 0.925105] Freeing unused kernel image (text/rodata gap) memory: 1216K867machine # [ 0.926653] Freeing unused kernel image (rodata/data gap) memory: 756K868sshClient # [ 0.912949] Freeing initrd memory: 28316K869sshClient # [ 0.916089] Freeing unused decrypted memory: 2028K870sshClient # [ 0.918619] Freeing unused kernel image (initmem) memory: 3644K871sshClient # [ 0.919763] Write protecting the kernel read-only data: 32768k872sshClient # [ 0.921652] Freeing unused kernel image (text/rodata gap) memory: 1216K873sshClient # [ 0.923262] Freeing unused kernel image (rodata/data gap) memory: 756K874machine # [ 0.977750] x86/mm: Checked W+X mappings: passed, no W+X pages found.875machine # [ 0.978842] Run /init as init process876machine # [ 0.988589] systemd[1]: Inserted module 'autofs4'877machine # [ 1.004791] fuse: init (API version 7.45)878machine # [ 1.010552] ACPI: \_SB_.GSIG: Enabled at IRQ 22879machine # [ 1.013048] ACPI: \_SB_.GSIH: Enabled at IRQ 23880machine # [ 1.017053] ACPI: \_SB_.GSIE: Enabled at IRQ 20881machine # [ 1.019706] ACPI: \_SB_.GSIF: Enabled at IRQ 21882sshClient # [ 0.974512] x86/mm: Checked W+X mappings: passed, no W+X pages found.883sshClient # [ 0.975590] Run /init as init process884sshClient # [ 0.985445] systemd[1]: Inserted module 'autofs4'885machine # [ 1.048514] systemd[1]: Successfully made /usr/ read-only.886sshClient # [ 1.001670] fuse: init (API version 7.45)887sshClient # [ 1.007552] ACPI: \_SB_.GSIG: Enabled at IRQ 22888sshClient # [ 1.010075] ACPI: \_SB_.GSIH: Enabled at IRQ 23889sshClient # [ 1.013344] ACPI: \_SB_.GSIE: Enabled at IRQ 20890sshClient # [ 1.015690] ACPI: \_SB_.GSIF: Enabled at IRQ 21891sshClient # [ 1.053207] systemd[1]: Successfully made /usr/ read-only.892machine # [ 1.384151] systemd[1]: systemd 262-d2a5296 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)893machine # [ 1.389467] systemd[1]: Detected virtualization kvm.894machine # [ 1.390366] systemd[1]: Detected architecture x86-64.895machine # [ 1.391257] systemd[1]: Running in initrd.896machine # [ 1.392516] systemd[1]: Initializing machine ID from random generator.897machine # [ 1.393790] systemd[1]: Hostname set to <machine>.898sshClient # [ 1.389916] systemd[1]: systemd 262-d2a5296 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)899sshClient # [ 1.402344] systemd[1]: Detected virtualization kvm.900sshClient # [ 1.404559] systemd[1]: Detected architecture x86-64.901sshClient # [ 1.406875] systemd[1]: Running in initrd.902sshClient # [ 1.409627] systemd[1]: Initializing machine ID from random generator.903sshClient # [ 1.412669] systemd[1]: Hostname set to <sshClient>.904machine # [ 1.467308] systemd[1]: bpf-restrict-fs: LSM BPF program attached905machine # [ 1.505247] systemd[1]: Queued start job for default target Initrd Default Target.906machine # [ 1.509722] systemd[1]: Created slice Slice /system/modprobe.907machine # [ 1.510952] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.908machine # [ 1.512398] systemd[1]: Expecting device /dev/disk/by-label/nixos...909machine # [ 1.513549] systemd[1]: Reached target Path Units.910machine # [ 1.514527] systemd[1]: Reached target Slice Units.911machine # [ 1.515517] systemd[1]: Reached target Swaps.912machine # [ 1.516364] systemd[1]: Reached target Timer Units.913machine # [ 1.517438] systemd[1]: Listening on D-Bus System Message Bus Socket.914machine # [ 1.518705] systemd[1]: Listening on Journal Socket (/dev/log).915machine # [ 1.519866] systemd[1]: Listening on Journal Sockets.916machine # [ 1.520886] systemd[1]: Listening on udev Kernel Socket.917machine # [ 1.521881] systemd[1]: Reached target Socket Units.918machine # [ 1.523768] systemd[1]: Starting Create List of Static Device Nodes...919machine # [ 1.528492] systemd[1]: Starting Load Kernel Module 9pnet_virtio...920machine # [ 1.535109] systemd[1]: Starting Load Kernel Module configfs...921machine # [ 1.552110] systemd[1]: Starting Journal Service...922sshClient # [ 1.507425] systemd[1]: bpf-restrict-fs: LSM BPF program attached923machine # [ 1.565533] systemd[1]: Starting Load Kernel Modules...924machine # [ 1.572521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os925machine # [ 1.588569] netfs: FS-Cache loaded926machine # [ 1.593477] 9pnet: Installing 9P2000 support927sshClient # [ 1.546924] systemd[1]: Queued start job for default target Initrd Default Target.928sshClient # [ 1.551388] systemd[1]: Created slice Slice /system/modprobe.929sshClient # [ 1.552645] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.930sshClient # [ 1.554095] systemd[1]: Expecting device /dev/disk/by-label/nixos...931machine # [ 1.605509] systemd[1]: Starting Coldplug All udev Devices...932sshClient # [ 1.555218] systemd[1]: Reached target Path Units.933sshClient # [ 1.556106] systemd[1]: Reached target Slice Units.934sshClient # [ 1.556981] systemd[1]: Reached target Swaps.935sshClient # [ 1.557849] systemd[1]: Reached target Timer Units.936sshClient # [ 1.558901] systemd[1]: Listening on D-Bus System Message Bus Socket.937sshClient # [ 1.560246] systemd[1]: Listening on Journal Socket (/dev/log).938sshClient # [ 1.561402] systemd[1]: Listening on Journal Sockets.939sshClient # [ 1.562430] systemd[1]: Listening on udev Kernel Socket.940sshClient # [ 1.563372] systemd[1]: Reached target Socket Units.941sshClient # [ 1.565217] systemd[1]: Starting Create List of Static Device Nodes...942machine # [ 1.620560] systemd[1]: Finished Create List of Static Device Nodes.943sshClient # [ 1.571112] systemd[1]: Starting Load Kernel Module 9pnet_virtio...944machine # [ 1.626155] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.945sshClient # [ 1.577233] systemd[1]: Starting Load Kernel Module configfs...946machine # [ 1.634815] systemd[1]: Finished Load Kernel Module 9pnet_virtio.947machine # [ 1.639906] systemd[1]: modprobe@configfs.service: Deactivated successfully.948machine # [ 1.644535] systemd-journald[67]: Collecting audit messages is disabled.949sshClient # [ 1.594118] systemd[1]: Starting Journal Service...950machine # [ 1.646832] systemd[1]: Finished Load Kernel Module configfs.951machine # [ 1.652898] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config952sshClient # [ 1.607120] systemd[1]: Starting Load Kernel Modules...953machine # [ 1.657811] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.954machine # [ 1.665518] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...955machine # [ 1.666876] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev956sshClient # [ 1.614126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os957sshClient # [ 1.630429] netfs: FS-Cache loaded958sshClient # [ 1.635547] 9pnet: Installing 9P2000 support959machine # [ 1.696947] systemd[1]: Finished Load Kernel Modules.960sshClient # [ 1.647812] systemd[1]: Starting Coldplug All udev Devices...961machine # [ 1.704614] systemd[1]: Starting Apply Kernel Variables...962sshClient # [ 1.664563] systemd[1]: Finished Create List of Static Device Nodes.963machine # [ 1.716597] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.964sshClient # [ 1.673221] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.965machine # [ 1.725614] systemd[1]: Starting Create Static Device Nodes in /dev...966sshClient # [ 1.679563] systemd[1]: Finished Load Kernel Module 9pnet_virtio.967sshClient # [ 1.685533] systemd[1]: modprobe@configfs.service: Deactivated successfully.968machine # [ 1.739028] systemd[1]: Finished Apply Kernel Variables.969sshClient # [ 1.688411] systemd-journald[67]: Collecting audit messages is disabled.970sshClient # [ 1.692479] systemd[1]: Finished Load Kernel Module configfs.971sshClient # [ 1.697184] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.972sshClient # [ 1.701630] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config973machine # [ 1.755734] systemd[1]: Started Journal Service.974machine # [ 1.614357] systemd-modules-load[68]: Inserted module 'dm_mod'975machine # [ 1.617216] systemd-modules-load[68]: Inserted module 'virtio_balloon'976sshClient # [ 1.708235] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev977machine # [ 1.619481] systemd-modules-load[68]: Inserted module 'virtio_gpu'978sshClient # [ 1.713276] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...979machine # [ 1.627114] systemd[1]: Finished Create Static Device Nodes in /dev.980machine # [ 1.629882] systemd[1]: Reached target Preparation for Local File Systems.981machine # [ 1.632741] systemd[1]: Reached target Local File Systems.982machine # [ 1.633781] systemd[1]: Starting Create System Files and Directories...983machine # [ 1.638985] systemd[1]: Starting Rule-based Manager for Device Events and Files...984sshClient # [ 1.742675] systemd[1]: Finished Load Kernel Modules.985sshClient # [ 1.752319] systemd[1]: Starting Apply Kernel Variables...986machine # [ 1.666675] systemd[1]: Finished Create System Files and Directories.987sshClient # [ 1.768155] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.988machine # [ 1.687393] systemd-udevd[83]: Using default interface naming scheme 'v261'.989sshClient # [ 1.778686] systemd[1]: Starting Create Static Device Nodes in /dev...990sshClient # [ 1.802673] systemd[1]: Finished Apply Kernel Variables.991machine # [ 1.711847] systemd[1]: Started Rule-based Manager for Device Events and Files.992sshClient # [ 1.671460] systemd-modules-load[68]: Inserted module 'dm_mod'[ 1.812701] systemd[1]: Started Journal Service.993sshClient # 994sshClient # [ 1.674646] systemd-modules-load[68]: Inserted module 'virtio_balloon'995sshClient # [ 1.675701] systemd-modules-load[68]: Inserted module 'virtio_gpu'996sshClient # [ 1.686918] systemd[1]: Finished Create Static Device Nodes in /dev.997sshClient # [ 1.689957] systemd[1]: Reached target Preparation for Local File Systems.998sshClient # [ 1.693080] systemd[1]: Reached target Local File Systems.999sshClient # [ 1.696070] systemd[1]: Starting Create System Files and Directories...1000sshClient # [ 1.700732] systemd[1]: Starting Rule-based Manager for Device Events and Files...1001machine # [ 1.750821] systemd[1]: Finished Coldplug All udev Devices.1002machine # [ 1.751671] systemd[1]: Reached target System Initialization.1003machine # [ 1.752468] systemd[1]: Reached target Basic System.1004sshClient # [ 1.737344] systemd[1]: Finished Create System Files and Directories.1005sshClient # [ 1.758273] systemd-udevd[83]: Using default interface naming scheme 'v261'.1006sshClient # [ 1.784420] systemd[1]: Started Rule-based Manager for Device Events and Files.1007sshClient # [ 1.824674] systemd[1]: Finished Coldplug All udev Devices.1008sshClient # [ 1.825570] systemd[1]: Reached target System Initialization.1009sshClient # [ 1.826389] systemd[1]: Reached target Basic System.1010machine # [ 2.086693] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121011machine # [ 2.093385] virtio_blk virtio5: 1/0/0 default/read/poll queues1012machine # [ 2.109731] serio: i8042 KBD port at 0x60,0x64 irq 11013machine # [ 2.110461] serio: i8042 AUX port at 0x60,0x64 irq 121014machine # [ 2.112081] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1015machine # [ 2.125240] uhci_hcd 0000:00:1d.0: UHCI Host Controller1016machine # [ 2.135401] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11017machine # [ 2.137166] uhci_hcd 0000:00:1d.0: detected 2 ports1018machine # [ 2.144035] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001019machine # [ 2.151016] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181020machine # [ 2.154687] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11021machine # [ 2.160438] usb usb1: Product: UHCI Host Controller1022machine # [ 2.161212] usb usb1: Manufacturer: Linux 6.18.48 uhci_hcd1023machine # [ 2.163446] usb usb1: SerialNumber: 0000:00:1d.01024machine # [ 2.166366] SCSI subsystem initialized1025machine # [ 2.169189] hub 1-0:1.0: USB hub found1026machine # [ 2.171440] hub 1-0:1.0: 2 ports detected1027machine # [ 2.174571] ehci-pci 0000:00:1d.7: EHCI Host Controller1028machine # [ 2.175274] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 21029machine # [ 2.176540] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001030machine # [ 2.182559] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001031machine # [ 2.184480] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181032machine # [ 2.185579] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11033machine # [ 2.189449] usb usb2: Product: EHCI Host Controller1034machine # [ 2.190334] usb usb2: Manufacturer: Linux 6.18.48 ehci_hcd1035machine # [ 2.192396] usb usb2: SerialNumber: 0000:00:1d.71036machine # [ 2.194001] hub 2-0:1.0: USB hub found1037machine # [ 2.195463] hub 2-0:1.0: 6 ports detected1038sshClient # [ 2.153782] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121039sshClient # [ 2.158057] virtio_blk virtio5: 1/0/0 default/read/poll queues1040machine # [ 2.067719] systemd[1]: Starting Virtual Console Setup...1041machine # [ 2.218740] hub 1-0:1.0: USB hub found1042machine # [ 2.220149] hub 1-0:1.0: 2 ports detected1043machine # [ 2.225850] uhci_hcd 0000:00:1d.1: UHCI Host Controller1044machine # [ 2.226648] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31045sshClient # [ 2.177783] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1046machine # [ 2.235172] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01047sshClient # [ 2.185827] serio: i8042 KBD port at 0x60,0x64 irq 11048sshClient # [ 2.196063] serio: i8042 AUX port at 0x60,0x64 irq 121049sshClient # [ 2.199814] ehci-pci 0000:00:1d.7: EHCI Host Controller1050sshClient # [ 2.200646] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11051machine # [ 2.109344] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1052sshClient # [ 2.202694] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001053machine # [ 2.113213] systemd[1]: Finished Virtual Console Setup.1054machine # [ 2.259770] uhci_hcd 0000:00:1d.1: detected 2 ports1055sshClient # [ 2.211064] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001056sshClient # [ 2.213178] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181057sshClient # [ 2.214332] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11058machine # [ 2.122729] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1059machine # [ 2.267800] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201060machine # [ 2.127277] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1061sshClient # [ 2.219162] usb usb1: Product: EHCI Host Controller1062sshClient # [ 2.219857] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd1063sshClient # [ 2.220893] usb usb1: SerialNumber: 0000:00:1d.71064sshClient # [ 2.222510] hub 1-0:1.0: USB hub found1065machine # [ 2.132556] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1066sshClient # [ 2.224342] hub 1-0:1.0: 6 ports detected1067sshClient # [ 2.227920] uhci_hcd 0000:00:1d.0: UHCI Host Controller1068sshClient # [ 2.228687] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21069machine # [ 2.280573] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181070machine # [ 2.287440] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11071sshClient # [ 2.241049] uhci_hcd 0000:00:1d.0: detected 2 ports1072sshClient # [ 2.241869] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001073machine # [ 2.295801] usb usb3: Product: UHCI Host Controller1074sshClient # [ 2.248868] SCSI subsystem initialized1075machine # [ 2.301443] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1076machine # [ 2.302230] usb usb3: SerialNumber: 0000:00:1d.11077sshClient # [ 2.253094] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181078sshClient # [ 2.254267] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11079machine # [ 2.307541] hub 3-0:1.0: USB hub found1080machine # [ 2.308776] hub 3-0:1.0: 2 ports detected1081machine # [ 2.173067] systemd[1]: Found device /dev/disk/by-label/nixos.1082machine # [ 2.173921] systemd[1]: Reached target Initrd Root Device.1083machine # [ 2.319281] uhci_hcd 0000:00:1d.2: UHCI Host Controller1084machine # [ 2.179071] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1085sshClient # [ 2.271063] usb usb2: Product: UHCI Host Controller1086sshClient # [ 2.271780] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd1087machine # [ 2.326748] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41088machine # [ 2.328435] uhci_hcd 0000:00:1d.2: detected 2 ports1089machine # [ 2.329245] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401090sshClient # [ 2.280955] usb usb2: SerialNumber: 0000:00:1d.01091sshClient # [ 2.283687] hub 2-0:1.0: USB hub found1092machine # [ 2.337275] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181093sshClient # [ 2.288298] hub 2-0:1.0: 2 ports detected1094machine # [ 2.341441] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11095machine # [ 2.345252] usb usb4: Product: UHCI Host Controller1096machine # [ 2.346312] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1097sshClient # [ 2.158054] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1098machine # [ 2.351221] usb usb4: SerialNumber: 0000:00:1d.21099sshClient # [ 2.302776] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01100machine # [ 2.354761] hub 4-0:1.0: USB hub found1101sshClient # [ 2.165433] systemd[1]: Starting Virtual Console Setup...1102machine # [ 2.356893] hub 4-0:1.0: 2 ports detected1103machine # [ 2.216311] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1104sshClient # [ 2.308189] uhci_hcd 0000:00:1d.1: UHCI Host Controller1105sshClient # [ 2.308912] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31106machine # [ 2.222544] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1107sshClient # [ 2.173172] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1108sshClient # [ 2.175345] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1109machine # [ 2.384981] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1110machine # [ 2.394639] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1111sshClient # [ 2.203349] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1112machine # [ 2.397479] ahci 0000:00:1f.2: flags: 64bit ncq only1113sshClient # [ 2.207351] systemd[1]: Finished Virtual Console Setup.1114sshClient # [ 2.355132] uhci_hcd 0000:00:1d.1: detected 2 ports1115machine # [ 2.406841] scsi host0: ahci1116sshClient # [ 2.355961] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201117machine # [ 2.410085] scsi host1: ahci1118machine # [ 2.412796] scsi host2: ahci1119machine # [ 2.415603] scsi host3: ahci1120machine # [ 2.418465] scsi host4: ahci1121sshClient # [ 2.368879] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181122machine # [ 2.421001] scsi host5: ahci1123machine # [ 2.422143] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11124machine # [ 2.423897] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11125sshClient # [ 2.373043] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11126machine # [ 2.425097] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11127sshClient # [ 2.374888] usb usb3: Product: UHCI Host Controller1128sshClient # [ 2.375623] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1129machine # [ 2.426313] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11130machine # [ 2.427558] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11131machine # [ 2.428741] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11132sshClient # [ 2.240781] systemd[1]: Found device /dev/disk/by-label/nixos.1133sshClient # [ 2.241827] systemd[1]: Reached target Initrd Root Device.1134machine # [ 2.434443] usb 2-1: new high-speed USB device number 2 using ehci-pci1135sshClient # [ 2.384126] usb usb3: SerialNumber: 0000:00:1d.11136sshClient # [ 2.246306] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1137sshClient # [ 2.391348] hub 3-0:1.0: USB hub found1138sshClient # [ 2.392538] hub 3-0:1.0: 2 ports detected1139sshClient # [ 2.396211] uhci_hcd 0000:00:1d.2: UHCI Host Controller1140sshClient # [ 2.396921] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41141sshClient # [ 2.409073] uhci_hcd 0000:00:1d.2: detected 2 ports1142sshClient # [ 2.409913] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401143sshClient # [ 2.414842] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181144sshClient # [ 2.418037] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11145sshClient # [ 2.422773] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1146sshClient # [ 2.425543] usb usb4: Product: UHCI Host Controller1147sshClient # [ 2.426714] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1148sshClient # [ 2.427888] usb usb4: SerialNumber: 0000:00:1d.21149sshClient # [ 2.289401] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1150sshClient # [ 2.430825] hub 4-0:1.0: USB hub found1151sshClient # [ 2.294628] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1152sshClient # [ 2.435790] hub 4-0:1.0: 2 ports detected1153sshClient # [ 2.437328] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1154sshClient # [ 2.440782] ahci 0000:00:1f.2: flags: 64bit ncq only1155sshClient # [ 2.446522] scsi host0: ahci1156sshClient # [ 2.447503] scsi host1: ahci1157sshClient # [ 2.448566] scsi host2: ahci1158sshClient # [ 2.451626] scsi host3: ahci1159sshClient # [ 2.454506] scsi host4: ahci1160sshClient # [ 2.456524] scsi host5: ahci1161sshClient # [ 2.458623] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11162sshClient # [ 2.459813] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11163sshClient # [ 2.464053] usb 1-1: new high-speed USB device number 2 using ehci-pci1164sshClient # [ 2.472567] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11165sshClient # [ 2.477991] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11166sshClient # [ 2.485069] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11167sshClient # [ 2.489047] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11168machine # [ 2.563838] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001169machine # [ 2.566858] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101170machine # [ 2.570090] usb 2-1: Product: QEMU USB Tablet1171machine # [ 2.572021] usb 2-1: Manufacturer: QEMU1172machine # [ 2.573808] usb 2-1: SerialNumber: 28754-0000:00:1d.7-11173machine # [ 2.605497] hid: raw HID events driver (C) Jiri Kosina1174machine # [ 2.472106] systemd[1]: Mounting /sysroot...1175sshClient # [ 2.593235] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001176sshClient # [ 2.596244] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101177sshClient # [ 2.599659] usb 1-1: Product: QEMU USB Tablet1178sshClient # [ 2.601606] usb 1-1: Manufacturer: QEMU1179sshClient # [ 2.603331] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11180sshClient # [ 2.633312] hid: raw HID events driver (C) Jiri Kosina1181sshClient # [ 2.521414] systemd[1]: Mounting /sysroot...1182machine # [ 2.737257] ata4: SATA link down (SStatus 0 SControl 300)1183machine # [ 2.739612] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1184machine # [ 2.741942] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001185machine # [ 2.744619] ata3.00: applying bridge limits1186machine # [ 2.746654] ata5: SATA link down (SStatus 0 SControl 300)1187machine # [ 2.748825] ata6: SATA link down (SStatus 0 SControl 300)1188machine # [ 2.751251] ata2: SATA link down (SStatus 0 SControl 300)1189machine # [ 2.753738] ata1: SATA link down (SStatus 0 SControl 300)1190machine # [ 2.755951] ata3.00: configured for UDMA/1001191machine # [ 2.759654] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51192machine # [ 2.826493] usbcore: registered new interface driver usbhid1193machine # [ 2.827330] usbhid: USB HID core driver1194machine # [ 2.845151] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input21195machine # [ 2.849874] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01196sshClient # [ 2.798973] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1197sshClient # [ 2.801409] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001198sshClient # [ 2.803887] ata3.00: applying bridge limits1199sshClient # [ 2.805869] ata5: SATA link down (SStatus 0 SControl 300)1200sshClient # [ 2.808219] ata2: SATA link down (SStatus 0 SControl 300)1201sshClient # [ 2.810388] ata1: SATA link down (SStatus 0 SControl 300)1202sshClient # [ 2.812895] ata4: SATA link down (SStatus 0 SControl 300)1203sshClient # [ 2.815321] ata6: SATA link down (SStatus 0 SControl 300)1204sshClient # [ 2.817434] ata3.00: configured for UDMA/1001205sshClient # [ 2.820101] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51206machine # [ 2.873788] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1207machine # [ 2.883526] cdrom: Uniform CD-ROM driver Revision: 3.201208machine # [ 2.887766] EXT4-fs (vda): mounted filesystem d031f27f-8f33-476b-803b-e4013b8c74c2 r/w with ordered data mode. Quota mode: none.1209machine # [ 2.753263] systemd[1]: Mounted /sysroot.1210machine # [ 2.755055] systemd[1]: Reached target Initrd Root File System.1211machine # [ 2.758079] systemd[1]: Starting Mountpoints Configured in the Real Root...1212machine # [ 2.772459] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload.1213machine # [ 2.775576] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)...1214machine # [ 2.777127] systemd[1]: Reloading...1215sshClient # [ 2.894167] usbcore: registered new interface driver usbhid1216sshClient # [ 2.894945] usbhid: USB HID core driver1217sshClient # [ 2.918508] 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/input21218sshClient # [ 2.922364] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01219sshClient # [ 2.926715] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1220sshClient # [ 2.938220] cdrom: Uniform CD-ROM driver Revision: 3.201221sshClient # [ 2.943661] EXT4-fs (vda): mounted filesystem dbda01bc-e125-44ab-8f52-10f634773e24 r/w with ordered data mode. Quota mode: none.1222sshClient # [ 2.809827] systemd[1]: Mounted /sysroot.1223machine # [ 2.859775] systemd[1]: Reloading finished in 81 ms.1224sshClient # [ 2.811949] systemd[1]: Reached target Initrd Root File System.1225sshClient # [ 2.817071] systemd[1]: Starting Mountpoints Configured in the Real Root...1226machine # [ 2.868042] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace...1227machine # [ 2.871165] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace...1228machine # [ 2.875901] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1229machine # [ 2.877333] systemd[1]: Finished Mountpoints Configured in the Real Root.1230machine # [ 2.879150] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1231machine # [ 2.881408] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1232sshClient # [ 2.833178] systemd-sysroot-fstab-check[141]: /sysroot should be mounted in the initrd, will request daemon-reload.1233sshClient # [ 2.836349] systemd[1]: Reload requested from client PID 141 ('systemd-sysroot') (unit initrd-parse-etc.service)...1234sshClient # [ 2.838064] systemd[1]: Reloading...1235sshClient # [ 2.914215] systemd[1]: Reloading finished in 75 ms.1236sshClient # [ 2.922485] systemd-sysroot-fstab-check[141]: Requesting initrd-fs.target/start/replace...1237sshClient # [ 2.926265] systemd-sysroot-fstab-check[141]: Requesting swap.target/start/replace...1238sshClient # [ 2.931044] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1239sshClient # [ 2.931992] systemd[1]: Finished Mountpoints Configured in the Real Root.1240sshClient # [ 2.932910] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1241sshClient # [ 2.935235] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1242machine # [ 3.474136] systemd[1]: Mounting /sysroot/nix/.ro-store...1243machine # [ 3.481183] systemd[1]: Mounting /sysroot/nix/.rw-store...1244machine # [ 3.490326] systemd[1]: Mounting /sysroot/run...1245machine # [ 3.502179] systemd[1]: Mounting /sysroot/tmp/shared...1246machine # [ 3.511915] systemd[1]: Mounting /sysroot/tmp/xchg...1247machine # [ 3.699438] 9p: Installing v9fs 9p2000 file system support1248machine # [ 3.559200] systemd[1]: Mounted /sysroot/nix/.rw-store.1249machine # [ 3.560584] systemd[1]: Mounted /sysroot/run.1250machine # [ 3.566673] systemd[1]: Mounted /sysroot/nix/.ro-store.1251machine # [ 3.568066] systemd[1]: Mounted /sysroot/tmp/shared.1252machine # [ 3.570341] systemd[1]: Mounted /sysroot/tmp/xchg.1253machine # [ 3.573705] systemd[1]: Starting rw-sysroot-nix-store.service...1254sshClient # [ 3.524183] systemd[1]: Mounting /sysroot/nix/.ro-store...1255sshClient # [ 3.531152] systemd[1]: Mounting /sysroot/nix/.rw-store...1256machine # [ 3.585242] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1257machine # [ 3.586663] systemd[1]: Finished rw-sysroot-nix-store.service.1258sshClient # [ 3.539160] systemd[1]: Mounting /sysroot/run...1259machine # [ 3.588876] systemd[1]: Mounting /sysroot/nix/store...1260sshClient # [ 3.549179] systemd[1]: Mounting /sysroot/tmp/shared...1261machine # [ 3.610115] systemd[1]: Mounted /sysroot/nix/store.1262sshClient # [ 3.560654] systemd[1]: Mounting /sysroot/tmp/xchg...1263machine # [ 3.611247] systemd[1]: Reached target Initrd File Systems.1264machine # [ 3.613074] systemd[1]: Starting Find NixOS closure...1265machine # [ 3.616137] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1266machine # [ 3.634360] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1267machine # [ 3.642793] systemd[1]: Finished Find NixOS closure.1268machine # [ 3.644222] systemd[1]: Reached target Initrd Default Target.1269machine # [ 3.645760] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1270sshClient # [ 3.601535] systemd[1]: Mounted /sysroot/nix/.rw-store.1271sshClient # [ 3.744841] 9p: Installing v9fs 9p2000 file system support1272sshClient # [ 3.606706] systemd[1]: Mounted /sysroot/run.1273machine # [ 3.660502] systemd[1]: Stopped target Initrd Default Target.1274machine # [ 3.661604] systemd[1]: Stopped target Basic System.1275machine # [ 3.663112] systemd[1]: Stopped target Initrd Root Device.1276machine # [ 3.663912] systemd[1]: Stopped target Path Units.1277machine # [ 3.664750] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1278machine # [ 3.665755] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1279sshClient # [ 3.617594] systemd[1]: Mounted /sysroot/nix/.ro-store.1280machine # [ 3.666848] systemd[1]: Stopped target Slice Units.1281sshClient # [ 3.618591] systemd[1]: Mounted /sysroot/tmp/shared.1282machine # [ 3.667816] systemd[1]: Stopped target Socket Units.1283sshClient # [ 3.619578] systemd[1]: Mounted /sysroot/tmp/xchg.1284machine # [ 3.668763] systemd[1]: Stopped target System Initialization.1285machine # [ 3.669930] systemd[1]: Stopped target Swaps.1286machine # [ 3.671046] systemd[1]: Stopped target Timer Units.1287sshClient # [ 3.623061] systemd[1]: Starting rw-sysroot-nix-store.service...1288machine # [ 3.671915] systemd[1]: dbus.socket: Deactivated successfully.1289machine # [ 3.673167] systemd[1]: Closed D-Bus System Message Bus Socket.1290machine # [ 3.673985] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1291machine # [ 3.675626] systemd[1]: Stopped Find NixOS closure.1292machine # [ 3.676301] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1293machine # [ 3.678067] systemd[1]: Starting rw-sysroot-nix-store.service...1294machine # [ 3.680058] systemd[1]: systemd-sysctl.service: Deactivated successfully.1295machine # [ 3.681114] systemd[1]: Stopped Apply Kernel Variables.1296machine # [ 3.682108] systemd[1]: systemd-modules-load.service: Deactivated successfully.1297machine # [ 3.683290] systemd[1]: Stopped Load Kernel Modules.1298sshClient # [ 3.635064] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1299machine # [ 3.684832] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1300sshClient # [ 3.637082] systemd[1]: Finished rw-sysroot-nix-store.service.1301machine # [ 3.685891] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1302machine # [ 3.686944] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1303sshClient # [ 3.638711] systemd[1]: Mounting /sysroot/nix/store...1304machine # [ 3.688080] systemd[1]: Stopped Create System Files and Directories.1305machine # [ 3.689671] systemd[1]: Stopped target Local File Systems.1306machine # [ 3.690470] systemd[1]: Stopped target Preparation for Local File Systems.1307machine # [ 3.692632] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1308machine # [ 3.693597] systemd[1]: Stopped Coldplug All udev Devices.1309machine # [ 3.695137] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1310machine # [ 3.697307] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1311machine # [ 3.698266] systemd[1]: Stopped Virtual Console Setup.1312sshClient # [ 3.660036] systemd[1]: Mounted /sysroot/nix/store.1313machine # [ 3.709151] systemd[1]: initrd-cleanup.service: Deactivated successfully.1314sshClient # [ 3.661449] systemd[1]: Reached target Initrd File Systems.1315machine # [ 3.711124] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1316sshClient # [ 3.663141] systemd[1]: Starting Find NixOS closure...1317machine # [ 3.712678] systemd[1]: systemd-udevd.service: Deactivated successfully.1318sshClient # [ 3.665619] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1319machine # [ 3.717123] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1320machine # [ 3.722162] systemd[1]: Starting Cleanup udev Database...1321machine # [ 3.722991] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1322machine # [ 3.724187] systemd[1]: Stopped Create Static Device Nodes in /dev.1323machine # [ 3.725213] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1324machine # [ 3.727209] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1325machine # [ 3.728271] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1326machine # [ 3.729262] systemd[1]: Stopped Create List of Static Device Nodes.1327machine # [ 3.730901] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1328machine # [ 3.733153] systemd[1]: Finished rw-sysroot-nix-store.service.1329sshClient # [ 3.684984] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1330sshClient # [ 3.695238] systemd[1]: Finished Find NixOS closure.1331sshClient # [ 3.696583] systemd[1]: Reached target Initrd Default Target.1332sshClient # [ 3.698767] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1333machine # [ 3.748802] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1334machine # [ 3.750492] systemd[1]: Finished Cleanup udev Database.1335machine # [ 3.751800] systemd[1]: Reached target Switch Root.1336machine # [ 3.753864] systemd[1]: Starting NixOS Activation...1337sshClient # [ 3.713084] systemd[1]: Stopped target Initrd Default Target.1338sshClient # [ 3.715194] systemd[1]: Stopped target Basic System.1339sshClient # [ 3.715930] systemd[1]: Stopped target Initrd Root Device.1340sshClient # [ 3.716702] systemd[1]: Stopped target Path Units.1341sshClient # [ 3.717376] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1342sshClient # [ 3.718317] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1343sshClient # [ 3.719374] systemd[1]: Stopped target Slice Units.1344sshClient # [ 3.720064] systemd[1]: Stopped target Socket Units.1345sshClient # [ 3.721205] systemd[1]: Stopped target System Initialization.1346sshClient # [ 3.722111] systemd[1]: Stopped target Swaps.1347sshClient # [ 3.722946] systemd[1]: Stopped target Timer Units.1348sshClient # [ 3.724023] systemd[1]: dbus.socket: Deactivated successfully.1349sshClient # [ 3.725105] systemd[1]: Closed D-Bus System Message Bus Socket.1350sshClient # [ 3.726115] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1351sshClient # [ 3.727796] systemd[1]: Stopped Find NixOS closure.1352sshClient # [ 3.728495] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1353sshClient # [ 3.730228] systemd[1]: Starting rw-sysroot-nix-store.service...1354sshClient # [ 3.732190] systemd[1]: systemd-sysctl.service: Deactivated successfully.1355sshClient # [ 3.733272] systemd[1]: Stopped Apply Kernel Variables.1356sshClient # [ 3.734287] systemd[1]: systemd-modules-load.service: Deactivated successfully.1357sshClient # [ 3.735611] systemd[1]: Stopped Load Kernel Modules.1358sshClient # [ 3.736546] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1359sshClient # [ 3.737887] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1360sshClient # [ 3.739163] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1361sshClient # [ 3.741110] systemd[1]: Stopped Create System Files and Directories.1362sshClient # [ 3.741950] systemd[1]: Stopped target Local File Systems.1363sshClient # [ 3.742907] systemd[1]: Stopped target Preparation for Local File Systems.1364sshClient # [ 3.744119] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1365sshClient # [ 3.746115] systemd[1]: Stopped Coldplug All udev Devices.1366sshClient # [ 3.746879] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1367sshClient # [ 3.748353] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1368sshClient # [ 3.750173] systemd[1]: Stopped Virtual Console Setup.1369sshClient # [ 3.757435] systemd[1]: initrd-cleanup.service: Deactivated successfully.1370sshClient # [ 3.761228] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1371sshClient # [ 3.768419] systemd[1]: systemd-udevd.service: Deactivated successfully.1372sshClient # [ 3.770126] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1373sshClient # [ 3.773179] systemd[1]: Starting Cleanup udev Database...1374sshClient # [ 3.774070] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1375sshClient # [ 3.776212] systemd[1]: Stopped Create Static Device Nodes in /dev.1376sshClient # [ 3.777205] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1377sshClient # [ 3.778354] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1378sshClient # [ 3.780147] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1379sshClient # [ 3.781134] systemd[1]: Stopped Create List of Static Device Nodes.1380sshClient # [ 3.781971] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1381sshClient # [ 3.784217] systemd[1]: Finished rw-sysroot-nix-store.service.1382sshClient # [ 3.798988] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1383sshClient # [ 3.800670] systemd[1]: Finished Cleanup udev Database.1384sshClient # [ 3.802141] systemd[1]: Reached target Switch Root.1385sshClient # [ 3.804080] systemd[1]: Starting NixOS Activation...1386machine # [ 3.914733] initrd-nixos-activation-start[192]: booting system configuration /nix/store/vlj94ad0g90ww17iw5fmq8hc2ndjkcsl-nixos-system-machine-test1387machine # [ 3.979993] initrd-nixos-activation-start[192]: running activation script...1388sshClient # [ 3.968249] initrd-nixos-activation-start[196]: booting system configuration /nix/store/y9ipcb2wlscdx9jc4mqc42ch9l81px5m-nixos-system-sshClient-test1389sshClient # [ 4.034443] initrd-nixos-activation-start[196]: running activation script...1390machine # [ 4.385826] initrd-nixos-activation-start[215]: setting up /etc...1391sshClient # [ 4.437236] initrd-nixos-activation-start[219]: setting up /etc...1392machine # [ 4.651767] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1393machine # [ 4.654066] systemd[1]: Finished NixOS Activation.1394machine # [ 4.655264] systemd[1]: Starting Switch Root...1395machine # [ 4.667179] systemd[1]: Switching root.1396sshClient # [ 4.693842] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1397sshClient # [ 4.695436] systemd[1]: Finished NixOS Activation.1398sshClient # [ 4.697364] systemd[1]: Starting Switch Root...1399sshClient # [ 4.710304] systemd[1]: Switching root.1400machine # [ 4.936141] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1401sshClient # [ 4.984792] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1402machine # [ 5.067797] NET: Registered PF_VSOCK protocol family1403sshClient # [ 5.123793] NET: Registered PF_VSOCK protocol family1404machine # [ 5.451335] systemd[1]: systemd 262-d2a5296 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)1405machine # [ 5.460929] systemd[1]: Detected virtualization kvm.1406machine # [ 5.462709] systemd[1]: Detected architecture x86-64.1407machine # [ 5.464618] systemd[1]: Detected first boot.1408machine # [ 5.471606] systemd[1]: Initializing machine ID from random generator.1409sshClient # [ 5.502935] systemd[1]: systemd 262-d2a5296 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)1410sshClient # [ 5.512452] systemd[1]: Detected virtualization kvm.1411sshClient # [ 5.514221] systemd[1]: Detected architecture x86-64.1412sshClient # [ 5.516123] systemd[1]: Detected first boot.1413sshClient # [ 5.523204] systemd[1]: Initializing machine ID from random generator.1414machine # [ 5.599017] systemd[1]: bpf-restrict-fs: LSM BPF program attached1415sshClient # [ 5.646315] systemd[1]: bpf-restrict-fs: LSM BPF program attached1416machine # [ 5.715906] systemd[1]: Applying preset policy.1417sshClient # [ 5.769529] systemd[1]: Applying preset policy.1418machine # [ 6.148867] systemd[1]: Populated /etc with preset unit settings.1419sshClient # [ 6.232841] systemd[1]: Populated /etc with preset unit settings.1420machine # [ 6.611136] systemd[1]: initrd-switch-root.service: Deactivated successfully.1421machine # [ 6.612709] systemd[1]: Stopped initrd-switch-root.service.1422machine # [ 6.615321] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1423machine # [ 6.617499] systemd[1]: Created slice Slice /system/getty.1424machine # [ 6.618811] systemd[1]: Created slice User and Session Slice.1425machine # [ 6.619921] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1426machine # [ 6.621167] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1427machine # [ 6.622261] systemd[1]: Expecting device /dev/hvc0...1428machine # [ 6.623016] systemd[1]: Expecting device /dev/ttyS0...1429machine # [ 6.623766] systemd[1]: Reached target Local Encrypted Volumes.1430machine # [ 6.624578] systemd[1]: Stopped target initrd-fs.target.1431machine # [ 6.625287] systemd[1]: Stopped target initrd-root-fs.target.1432machine # [ 6.626112] systemd[1]: Stopped target initrd-switch-root.target.1433machine # [ 6.626984] systemd[1]: Reached target Virtual Machines and Containers.1434machine # [ 6.627904] systemd[1]: Reached target Path Units.1435machine # [ 6.628594] systemd[1]: Reached target Remote File Systems.1436machine # [ 6.629349] systemd[1]: Reached target Slice Units.1437machine # [ 6.641533] systemd[1]: Reached target Swaps.1438machine # [ 6.644515] systemd[1]: Listening on Query the User Interactively for a Password.1439machine # [ 6.648036] systemd[1]: Listening on Process Core Dump Socket.1440machine # [ 6.650591] systemd[1]: Listening on Credential Encryption/Decryption.1441machine # [ 6.657339] systemd[1]: Listening on Factory Reset Management.1442machine # [ 6.658291] systemd[1]: Listening on Hostname Service Socket.1443machine # [ 6.661385] systemd[1]: Starting Journal Log Access Socket...1444machine # [ 6.663132] systemd[1]: Listening on Journal Audit Socket.1445machine # [ 6.665586] systemd[1]: Listening on Console Output Muting Service Socket.1446machine # [ 6.667020] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1447machine # [ 6.668525] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1448machine # [ 6.669886] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1449machine # [ 6.677509] systemd[1]: Listening on Disk Repartitioning Service Socket.1450machine # [ 6.678533] systemd[1]: Listening on udev Varlink Socket.1451machine # [ 6.679439] systemd[1]: Listening on User Database Manager Socket.1452machine # [ 6.683837] systemd[1]: Mounting Huge Pages File System...1453machine # [ 6.686788] systemd[1]: Mounting POSIX Message Queue File System...1454machine # [ 6.692939] systemd[1]: Mounting Kernel Debug File System...1455machine # [ 6.698613] systemd[1]: Mounting Kernel Trace File System...1456machine # [ 6.704220] systemd[1]: Starting Create List of Static Device Nodes...1457machine # [ 6.706976] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1458machine # [ 6.717305] systemd[1]: Starting Load Kernel Module configfs...1459machine # [ 6.718810] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1460machine # [ 6.720619] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1461machine # [ 6.722117] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1462machine # [ 6.728901] systemd[1]: Mounting FUSE Control File System...1463machine # [ 6.731204] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671464sshClient # [ 6.697220] systemd[1]: initrd-switch-root.service: Deactivated successfully.1465sshClient # [ 6.698705] systemd[1]: Stopped initrd-switch-root.service.1466sshClient # [ 6.701494] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1467sshClient # [ 6.703753] systemd[1]: Created slice Slice /system/getty.1468sshClient # [ 6.705219] systemd[1]: Created slice User and Session Slice.1469sshClient # [ 6.706318] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1470sshClient # [ 6.707519] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1471sshClient # [ 6.708644] systemd[1]: Expecting device /dev/hvc0...1472sshClient # [ 6.709387] systemd[1]: Expecting device /dev/ttyS0...1473sshClient # [ 6.710170] systemd[1]: Reached target Local Encrypted Volumes.1474sshClient # [ 6.710966] systemd[1]: Stopped target initrd-fs.target.1475sshClient # [ 6.711753] systemd[1]: Stopped target initrd-root-fs.target.1476sshClient # [ 6.712547] systemd[1]: Stopped target initrd-switch-root.target.1477sshClient # [ 6.713440] systemd[1]: Reached target Virtual Machines and Containers.1478sshClient # [ 6.714364] systemd[1]: Reached target Path Units.1479sshClient # [ 6.715082] systemd[1]: Reached target Remote File Systems.1480sshClient # [ 6.715875] systemd[1]: Reached target Slice Units.1481sshClient # [ 6.716613] systemd[1]: Reached target Swaps.1482machine # [ 6.768048] systemd[1]: Starting Journal Service...1483sshClient # [ 6.719183] systemd[1]: Listening on Query the User Interactively for a Password.1484machine # [ 6.782511] systemd[1]: Starting Load Kernel Modules...1485sshClient # [ 6.734288] systemd[1]: Listening on Process Core Dump Socket.1486sshClient # [ 6.736777] systemd[1]: Listening on Credential Encryption/Decryption.1487sshClient # [ 6.739164] systemd[1]: Listening on Factory Reset Management.1488sshClient # [ 6.740106] systemd[1]: Listening on Hostname Service Socket.1489sshClient # [ 6.743510] systemd[1]: Starting Journal Log Access Socket...1490sshClient # [ 6.745569] systemd[1]: Listening on Journal Audit Socket.1491sshClient # [ 6.748433] systemd[1]: Listening on Console Output Muting Service Socket.1492sshClient # [ 6.749538] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1493sshClient # [ 6.751157] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1494sshClient # [ 6.752538] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1495machine # [ 6.805484] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1496sshClient # [ 6.760598] systemd[1]: Listening on Disk Repartitioning Service Socket.1497sshClient # [ 6.761715] systemd[1]: Listening on udev Varlink Socket.1498sshClient # [ 6.762700] systemd[1]: Listening on User Database Manager Socket.1499machine # [ 6.815511] systemd[1]: Starting Remount Root and Kernel File Systems...1500sshClient # [ 6.766569] systemd[1]: Mounting Huge Pages File System...1501sshClient # [ 6.769648] systemd[1]: Mounting POSIX Message Queue File System...1502machine # [ 6.823773] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1503sshClient # [ 6.775931] systemd[1]: Mounting Kernel Debug File System...1504sshClient # [ 6.782281] systemd[1]: Mounting Kernel Trace File System...1505machine # [ 6.838493] systemd[1]: Starting Coldplug All udev Devices...1506sshClient # [ 6.788116] systemd[1]: Starting Create List of Static Device Nodes...1507sshClient # [ 6.790324] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1508sshClient # [ 6.802751] systemd[1]: Starting Load Kernel Module configfs...1509sshClient # [ 6.803874] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1510sshClient # [ 6.805867] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1511machine # [ 6.857260] systemd-journald[286]: Collecting audit messages is enabled.1512sshClient # [ 6.807916] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1513machine # [ 6.861511] systemd[1]: Listening on Journal Log Access Socket.1514machine # [ 6.866093] systemd[1]: Mounted Huge Pages File System.1515sshClient # [ 6.818489] systemd[1]: Mounting FUSE Control File System...1516machine # [ 6.871340] systemd[1]: Mounted POSIX Message Queue File System.1517sshClient # [ 6.824114] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671518machine # [ 6.878263] systemd[1]: Mounted Kernel Debug File System.1519machine # [ 6.885833] systemd[1]: Mounted Kernel Trace File System.1520machine # [ 6.886757] loop: module loaded1521machine # [ 6.891311] systemd[1]: Finished Create List of Static Device Nodes.1522machine # [ 6.892492] EXT4-fs (vda): re-mounted d031f27f-8f33-476b-803b-e4013b8c74c2.1523machine # [ 6.897298] systemd[1]: modprobe@configfs.service: Deactivated successfully.1524machine # [ 6.757423] systemd[1]: Queued start job for default target Multi-User System.1525sshClient # [ 6.849287] systemd[1]: Starting Journal Service...1526machine # [ 6.759035] systemd[1]: systemd-journald.service: Deactivated successfully.1527machine # [ 6.761379] systemd-modules-load[287]: Inserted module 'loop'1528machine # [ 6.904864] systemd[1]: Finished Load Kernel Module configfs.1529machine # [ 6.911450] systemd[1]: Started Journal Service.1530machine # [ 6.774714] systemd[1]: Mounted FUSE Control File System.1531machine # [ 6.776165] systemd[1]: Finished Load Kernel Modules.1532sshClient # [ 6.867460] systemd[1]: Starting Load Kernel Modules...1533machine # [ 6.780174] systemd[1]: Finished Remount Root and Kernel File Systems.1534machine # [ 6.795067] systemd[1]: Listening on Disk Image Download Service Socket.1535machine # [ 6.802111] systemd[1]: Mounting Kernel Configuration File System...1536sshClient # [ 6.893696] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1537machine # [ 6.808069] systemd[1]: Starting Firewall...1538sshClient # [ 6.903590] systemd[1]: Starting Remount Root and Kernel File Systems...1539machine # [ 6.818131] systemd[1]: Starting Flush Journal to Persistent Storage...1540machine # [ 6.821120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1541machine # [ 6.823371] systemd-oomd[288]: No swap; memory pressure usage will be degraded1542sshClient # [ 6.915600] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1543machine # [ 6.832075] systemd[1]: Starting Load/Save OS Random Seed...1544sshClient # [ 6.932331] systemd[1]: Starting Coldplug All udev Devices...1545sshClient # [ 6.935494] systemd-journald[290]: Collecting audit messages is enabled.1546machine # [ 6.844952] systemd[1]: Starting Apply Kernel Variables...1547machine # [ 6.865188] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1548machine # [ 6.867077] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1549sshClient # [ 6.959623] systemd[1]: Listening on Journal Log Access Socket.1550sshClient # [ 6.966372] systemd[1]: Mounted Huge Pages File System.1551sshClient # [ 6.827706] systemd[1]: Queued start job for default target Multi-User System.1552machine # [ 6.880547] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1553sshClient # [ 6.972848] systemd[1]: Started Journal Service.1554sshClient # [ 6.832139] systemd[1]: systemd-journald.service: Deactivated successfully.1555machine # [ 7.033270] systemd-journald[286]: Received client request to flush runtime journal.1556sshClient # [ 6.983258] EXT4-fs (vda): re-mounted dbda01bc-e125-44ab-8f52-10f634773e24.1557sshClient # [ 6.847276] systemd[1]: Mounted POSIX Message Queue File System.1558sshClient # [ 6.848330] systemd[1]: Mounted Kernel Debug File System.1559sshClient # [ 6.849116] systemd[1]: Mounted Kernel Trace File System.1560sshClient # [ 6.993423] loop: module loaded1561sshClient # [ 6.855086] systemd[1]: Finished Create List of Static Device Nodes.1562sshClient # [ 6.856081] systemd[1]: modprobe@configfs.service: Deactivated successfully.1563sshClient # [ 6.857977] systemd-modules-load[291]: Inserted module 'loop'1564sshClient # [ 6.861519] systemd[1]: Finished Load Kernel Module configfs.1565sshClient # [ 6.864749] systemd[1]: Mounted FUSE Control File System.1566sshClient # [ 6.865929] systemd[1]: Finished Load Kernel Modules.1567sshClient # [ 6.871154] systemd[1]: Finished Remount Root and Kernel File Systems.1568sshClient # [ 6.883663] systemd[1]: Listening on Disk Image Download Service Socket.1569sshClient # [ 6.894065] systemd[1]: Mounting Kernel Configuration File System...1570sshClient # [ 6.900071] systemd[1]: Starting Firewall...1571sshClient # [ 6.910063] systemd[1]: Starting Flush Journal to Persistent Storage...1572sshClient # [ 6.910965] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1573sshClient # [ 6.921531] systemd[1]: Starting Load/Save OS Random Seed...1574sshClient # [ 6.929788] systemd-oomd[293]: No swap; memory pressure usage will be degraded1575sshClient # [ 6.938575] systemd[1]: Starting Apply Kernel Variables...1576sshClient # [ 6.956314] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1577sshClient # [ 6.957356] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1578sshClient # [ 6.959151] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1579machine # [ 7.034646] systemd[1]: Finished Load/Save OS Random Seed.1580machine # [ 7.040083] systemd[1]: Mounted Kernel Configuration File System.1581machine # [ 7.041138] systemd[1]: Finished Apply Kernel Variables.1582machine # [ 7.041938] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1583machine # [ 7.042900] systemd[1]: Starting Create Static Device Nodes in /dev...1584sshClient # [ 7.137909] systemd-journald[290]: Received client request to flush runtime journal.1585machine # [ 7.048074] systemd[1]: Finished Flush Journal to Persistent Storage.1586machine # [ 7.123125] systemd[1]: Finished Create Static Device Nodes in /dev.1587machine # [ 7.124136] systemd[1]: Reached target Preparation for Local File Systems.1588machine # [ 7.129154] systemd[1]: Starting Rule-based Manager for Device Events and Files...1589machine # [ 7.174343] systemd[1]: Finished Coldplug All udev Devices.1590sshClient # [ 7.127405] systemd[1]: Finished Load/Save OS Random Seed.1591sshClient # [ 7.128429] systemd[1]: Mounted Kernel Configuration File System.1592sshClient # [ 7.129299] systemd[1]: Finished Apply Kernel Variables.1593sshClient # [ 7.130080] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1594sshClient # [ 7.137093] systemd[1]: Starting Create Static Device Nodes in /dev...1595sshClient # [ 7.138481] systemd[1]: Finished Flush Journal to Persistent Storage.1596machine # [ 7.212576] systemd-udevd[327]: Using default interface naming scheme 'v261'.1597sshClient # [ 7.209790] systemd[1]: Finished Create Static Device Nodes in /dev.1598sshClient # [ 7.210722] systemd[1]: Reached target Preparation for Local File Systems.1599sshClient # [ 7.215566] systemd[1]: Starting Rule-based Manager for Device Events and Files...1600machine # [ 7.272816] systemd[1]: Starting User Database Manager...1601machine # [ 7.322178] systemd[1]: Started User Database Manager.1602sshClient # [ 7.277344] systemd[1]: Finished Coldplug All udev Devices.1603sshClient # [ 7.300120] systemd-udevd[331]: Using default interface naming scheme 'v261'.1604machine # [ 7.394768] systemd[1]: Started Rule-based Manager for Device Events and Files.1605sshClient # [ 7.355939] systemd[1]: Starting User Database Manager...1606sshClient # [ 7.404902] systemd[1]: Started User Database Manager.1607machine # [ 7.474356] systemd[1]: Mounting /run/wrappers...1608machine # [ 7.520165] systemd[1]: Mounted /run/wrappers.1609machine # [ 7.522592] systemd[1]: Reached target Local File Systems.1610sshClient # [ 7.474796] systemd[1]: Started Rule-based Manager for Device Events and Files.1611machine # [ 7.526367] systemd[1]: Listening on Boot Loader Control Service Socket.1612machine # [ 7.529957] systemd[1]: Starting register-nix-paths.service...1613machine # [ 7.537292] systemd[1]: Starting Create SUID/SGID Wrappers...1614machine # [ 7.538762] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1615machine # [ 7.548067] systemd[1]: Starting Create System Files and Directories...1616machine # [ 7.572417] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1617sshClient # [ 7.562527] systemd[1]: Mounting /run/wrappers...1618sshClient # [ 7.612422] systemd[1]: Mounted /run/wrappers.1619sshClient # [ 7.614982] systemd[1]: Reached target Local File Systems.1620sshClient # [ 7.618989] systemd[1]: Listening on Boot Loader Control Service Socket.1621sshClient # [ 7.621973] systemd[1]: Starting register-nix-paths.service...1622sshClient # [ 7.626796] systemd[1]: Starting Create SUID/SGID Wrappers...1623sshClient # [ 7.628802] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1624machine # [ 7.680595] systemd[1]: Finished Create System Files and Directories.1625sshClient # [ 7.641952] systemd[1]: Starting Create System Files and Directories...1626machine # [ 7.691246] systemd[1]: Starting Rebuild Journal Catalog...1627machine # [ 7.696441] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1628sshClient # [ 7.649169] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1629machine # [ 7.790296] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1630machine # [ 7.793381] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1631sshClient # [ 7.770289] systemd[1]: Finished Create System Files and Directories.1632sshClient # [ 7.782123] systemd[1]: Starting Rebuild Journal Catalog...1633sshClient # [ 7.786791] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1634machine # [ 7.838790] systemd[1]: Finished Rebuild Journal Catalog.1635machine # [ 7.846033] systemd[1]: Starting Update is Completed...1636machine # [ 7.848931] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1637sshClient # [ 7.850930] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1638machine # [ 7.910375] systemd[1]: Finished Update is Completed.1639sshClient # [ 7.891560] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1640machine # [ 7.945649] (udev-worker)[383]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1641machine # [ 7.952804] (udev-worker)[377]: Network interface NamePolicy= disabled on kernel command line.1642machine # [ 7.954920] (udev-worker)[383]: Network interface NamePolicy= disabled on kernel command line.1643sshClient # [ 7.913369] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1644sshClient # [ 7.939556] systemd[1]: Finished Rebuild Journal Catalog.1645sshClient # [ 7.946979] systemd[1]: Starting Update is Completed...1646sshClient # [ 8.003198] (udev-worker)[384]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1647sshClient # [ 8.007560] systemd[1]: Finished Update is Completed.1648sshClient # [ 8.013431] (udev-worker)[383]: Network interface NamePolicy= disabled on kernel command line.1649sshClient # [ 8.016500] (udev-worker)[384]: Network interface NamePolicy= disabled on kernel command line.1650machine # [ 8.145587] systemd[1]: Condition check resulted in Virtio network device being skipped.1651machine # [ 8.147985] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1652machine # [ 8.150351] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1653machine # [ 8.153213] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671654machine # [ 8.155168] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1655machine # [ 8.156589] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1656machine # [ 8.157876] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1657machine # [ 8.220491] systemd[1]: Finished Firewall.1658machine # [ 8.228561] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1659machine # [ 8.231185] systemd[1]: Finished Create SUID/SGID Wrappers.1660sshClient # [ 8.207304] systemd[1]: Condition check resulted in Virtio network device being skipped.1661sshClient # [ 8.209264] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1662sshClient # [ 8.212318] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1663sshClient # [ 8.214343] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671664sshClient # [ 8.216793] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1665sshClient # [ 8.219130] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1666sshClient # [ 8.221403] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1667machine # [ 8.445026] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1668sshClient # [ 8.311698] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1669sshClient # [ 8.314560] systemd[1]: Finished Create SUID/SGID Wrappers.1670sshClient # [ 8.317490] systemd[1]: Finished Firewall.1671machine # [ 8.423993] systemd[1]: Finished register-nix-paths.service.1672machine # [ 8.425198] systemd[1]: Reached target System Initialization.1673sshClient # [ 8.516667] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31674machine # [ 8.426755] systemd[1]: Started Discard unused filesystem blocks once a week.1675machine # [ 8.427829] systemd[1]: Started Daily Cleanup of Temporary Directories.1676machine # [ 8.428831] systemd[1]: Reached target Timer Units.1677machine # [ 8.430214] systemd[1]: Listening on D-Bus System Message Bus Socket.1678machine # [ 8.431579] systemd[1]: Listening on Nix Daemon Socket.1679machine # [ 8.443902] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1680machine # [ 8.445173] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1681machine # [ 8.446384] systemd[1]: Reached target Socket Units.1682machine # [ 8.448716] systemd[1]: Reached target Basic System.1683sshClient # [ 8.540043] ACPI: button: Power Button [PWRF]1684machine # [ 8.451566] systemd[1]: Started backdoor.service.1685machine # [ 8.455193] systemd[1]: Starting Import lastlog data into lastlog2 database...1686machine # [ 8.450423] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31687machine # [ 8.463156] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1688sshClient # [ 8.558627] mousedev: PS/2 mouse device common for all mice1689machine # [ 8.471156] systemd[1]: Starting Post-Boot Actions...1690machine # [ 8.467439] ACPI: button: Power Button [PWRF]1691machine # [ 8.468827] mousedev: PS/2 mouse device common for all mice1692machine # [ 8.485933] systemd[1]: Started Reset console on configuration changes.1693sshClient # [ 8.589140] rtc_cmos 00:04: RTC can wake from S41694machine # [ 8.506625] systemd[1]: Starting resolvconf update...1695machine # [ 8.551274] rtc_cmos 00:04: RTC can wake from S41696machine # [ 8.574723] rtc_cmos 00:04: registered as rtc01697machine # [ 8.519535] systemd[1]: Starting SSH Host Keys Generation...1698sshClient # [ 8.625617] rtc_cmos 00:04: registered as rtc01699sshClient # [ 8.636018] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1700machine # [ 8.556380] systemd[1]: Starting Home Area Manager...1701machine # [ 8.574815] rtc_cmos 00:04: setting system clock to 2026-09-02T02:46:27 UTC (1788317187)1702machine # [ 8.574945] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1703machine # connecting to host...1704machine # [ 8.583684] systemd[1]: Finished Post-Boot Actions.1705sshClient # [ 8.547715] systemd[1]: Finished register-nix-paths.service.1706sshClient # [ 8.549231] systemd[1]: Reached target System Initialization.1707machine # [ 8.597992] nsncd[518]: Sep 02 02:46:27.662 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1708sshClient # [ 8.552081] systemd[1]: Started Discard unused filesystem blocks once a week.1709sshClient # [ 8.553068] systemd[1]: Started Daily Cleanup of Temporary Directories.1710sshClient # [ 8.553934] systemd[1]: Reached target Timer Units.1711sshClient # [ 8.554634] systemd[1]: Listening on D-Bus System Message Bus Socket.1712sshClient # [ 8.555492] systemd[1]: Listening on Nix Daemon Socket.1713sshClient # [ 8.556374] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1714machine # [ 8.605963] systemd[1]: Started Name Service Cache Daemon (nsncd).1715sshClient # [ 8.558360] systemd[1]: Reached target Socket Units.1716sshClient # [ 8.559088] systemd[1]: Reached target Basic System.1717sshClient # [ 8.563163] systemd[1]: Started backdoor.service.1718machine: Guest shell says: b'Spawning backdoor root shell...\n'1719sshClient # [ 8.568560] systemd[1]: Starting Import lastlog data into lastlog2 database...1720machine # [ 8.629229] systemd[1]: Reached target Host and Network Name Lookups.1721sshClient # [ 8.583861] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1722machine # [ 8.630225] systemd[1]: Reached target User and Group Name Lookups.1723machine: connected to guest root shell1724machine # [ 8.644457] systemd[1]: Starting D-Bus System Message Bus...1725machine: (connecting took 9.31 seconds)1726machine # [ 8.577116] parport_pc 00:02: reported by Plug and Play ACPI1727machine: (finished: waiting for the VM to finish booting, in 9.31 seconds)1728machine # [ 8.577192] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1729sshClient # [ 8.591101] systemd[1]: Starting Post-Boot Actions...1730sshClient # [ 8.603064] systemd[1]: Started Reset console on configuration changes.1731sshClient # [ 8.615124] systemd[1]: Starting resolvconf update...1732machine # [ 8.670933] systemd[1]: Starting User Login Management...1733sshClient # [ 8.647206] systemd[1]: Starting Home Area Manager...1734machine # [ 8.700718] systemd[1]: Finished Import lastlog data into lastlog2 database.1735machine # [ 8.583517] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41736machine # [ 8.601220] Console: switching to colour dummy device 80x251737machine # [ 8.632916] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1738machine # [ 8.722828] systemd-homed[526]: Watching /home.1739sshClient # connecting to host...1740sshClient # [ 8.691468] nsncd[516]: Sep 02 02:46:27.676 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1741sshClient # [ 8.696103] systemd[1]: Started Name Service Cache Daemon (nsncd).1742sshClient # [ 8.709243] systemd[1]: Finished Post-Boot Actions.1743sshClient # [ 8.726453] systemd[1]: Reached target Host and Network Name Lookups.1744sshClient # [ 8.730042] systemd[1]: Reached target User and Group Name Lookups.1745sshClient # [ 8.739221] systemd[1]: Starting D-Bus System Message Bus...1746sshClient # [ 8.764643] systemd[1]: Starting User Login Management...1747sshClient # [ 8.771224] systemd[1]: Finished Import lastlog data into lastlog2 database.1748machine # [ 8.936985] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1749machine # [ 8.937088] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1750machine # [ 8.966808] [drm] Found bochs VGA, ID 0xb0c5.1751machine # [ 8.966810] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1752machine # [ 8.857223] systemd[1]: Stopped target Host and Network Name Lookups.1753machine # [ 8.858622] systemd[1]: Stopping Host and Network Name Lookups...1754machine # [ 8.860701] systemd[1]: Stopped target User and Group Name Lookups.1755machine # [ 8.863144] systemd[1]: Stopping User and Group Name Lookups...1756machine # [ 8.864507] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1757sshClient # [ 8.815284] systemd-homed[523]: Watching /home.1758sshClient # [ 8.645374] parport_pc 00:02: reported by Plug and Play ACPI1759sshClient # [ 8.645458] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1760machine # [ 8.872345] systemd[1]: nscd.service: Deactivated successfully.1761machine # [ 8.876869] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1762machine # [ 8.885485] dbus-broker-launch[547]: Looking up NSS user entry for 'systemd-timesync'...1763machine # [ 9.037743] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1764machine # [ 8.904334] dbus-broker-launch[547]: NSS returned no entry for 'systemd-timesync'1765machine # [ 8.905429] dbus-broker-launch[547]: Invalid user-name in /nix/store/9smdp417x6nbff8vbb9l7j02n2x4yvza-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1766sshClient # [ 8.650900] rtc_cmos 00:04: setting system clock to 2026-09-02T02:46:27 UTC (1788317187)1767sshClient # [ 8.651607] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1768machine # [ 8.910669] systemd-logind[552]: New seat seat0.1769machine # [ 8.912930] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1770machine # [ 8.916849] systemd[1]: Started User Login Management.1771machine # [ 9.080409] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01772sshClient # [ 8.654803] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41773sshClient # [ 8.701481] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1774sshClient # [ 8.916477] systemd[1]: Stopped target Host and Network Name Lookups.1775sshClient # [ 8.918170] systemd[1]: Stopping Host and Network Name Lookups...1776machine # [ 8.967978] systemd[1]: Starting linger-users.service...1777sshClient # [ 8.919609] systemd[1]: Stopped target User and Group Name Lookups.1778machine # [ 8.968885] systemd[1]: Started D-Bus System Message Bus.1779sshClient # [ 8.921459] systemd[1]: Stopping User and Group Name Lookups...1780sshClient # [ 8.922449] dbus-broker-launch[543]: Looking up NSS user entry for 'systemd-timesync'...1781sshClient # [ 8.925241] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1782sshClient # [ 8.926787] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1783sshClient # [ 8.926906] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1784sshClient # [ 8.959051] Console: switching to colour dummy device 80x251785machine # [ 9.142078] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61786machine # [ 9.006582] dbus-broker-launch[547]: Ready1787machine # [ 9.009059] systemd[1]: Finished resolvconf update.1788machine # [ 9.152938] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51789machine # [ 9.016865] systemd[1]: Reached target Preparation for Network.1790sshClient # [ 9.100580] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61791sshClient # [ 9.100930] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51792sshClient # [ 8.953867] systemd[1]: nscd.service: Deactivated successfully.1793sshClient # [ 8.978982] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1794sshClient # [ 8.979822] dbus-broker-launch[543]: NSS returned no entry for 'systemd-timesync'1795machine # [ 9.029066] systemd[1]: Starting DHCP Client...1796sshClient # [ 8.981037] dbus-broker-launch[543]: Invalid user-name in /nix/store/59mf9rg48a6r7m3f2sr50hixfxnba02v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1797machine # [ 9.034167] systemd[1]: Starting Address configuration of eth1...1798sshClient # [ 8.983281] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1799sshClient # [ 8.987039] systemd-logind[544]: New seat seat0.1800sshClient # [ 8.989284] systemd[1]: Started User Login Management.1801machine # [ 9.044231] systemd[1]: Starting Extra networking commands....1802machine # [ 9.045291] nsncd[608]: Sep 02 02:46:28.111 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1803machine # [ 9.048842] systemd[1]: Started Name Service Cache Daemon (nsncd).1804sshClient # [ 9.000817] systemd[1]: Starting linger-users.service...1805machine # [ 9.051916] systemd[1]: Started Home Area Manager.1806sshClient # [ 9.006498] systemd[1]: Started D-Bus System Message Bus.1807sshClient # [ 9.149341] [drm] Found bochs VGA, ID 0xb0c5.1808sshClient # [ 9.149857] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1809sshClient # [ 9.032211] systemd[1]: Starting Virtual Console Setup...1810machine # [ 9.084644] systemd[1]: linger-users.service: Deactivated successfully.1811sshClient # [ 9.039151] systemd[1]: Finished resolvconf update.1812machine # [ 9.091150] systemd[1]: Finished linger-users.service.1813sshClient # [ 9.045106] systemd[1]: Reached target Preparation for Network.1814sshClient # [ 9.193192] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1815sshClient # [ 9.193906] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01816machine # [ 9.108633] systemd[1]: Reached target Host and Network Name Lookups.1817machine # [ 9.109525] systemd[1]: Reached target User and Group Name Lookups.1818machine # [ 9.110304] systemd[1]: Finished Home Area Activation.1819sshClient # [ 9.064934] dbus-broker-launch[543]: Ready1820sshClient # [ 9.072125] systemd[1]: Starting DHCP Client...1821machine # [ 9.123873] systemd[1]: Starting First Boot Home Area Wizard...1822sshClient # [ 9.075823] nsncd[601]: Sep 02 02:46:28.062 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1823sshClient # [ 9.080653] systemd[1]: Starting Address configuration of eth1...1824machine # [ 9.136621] systemd[1]: Starting Virtual Console Setup...1825sshClient # [ 9.094505] systemd[1]: Starting Extra networking commands....1826sshClient # [ 9.105670] systemd[1]: Started Name Service Cache Daemon (nsncd).1827sshClient # [ 9.115515] systemd[1]: linger-users.service: Deactivated successfully.1828sshClient # [ 9.119092] systemd[1]: Finished linger-users.service.1829sshClient # [ 9.149489] systemd[1]: Started Home Area Manager.1830sshClient # [ 9.162967] systemd[1]: Reached target Host and Network Name Lookups.1831sshClient # [ 9.164168] systemd[1]: Reached target User and Group Name Lookups.1832sshClient # [ 9.167160] systemd[1]: Finished Home Area Activation.1833sshClient # [ 9.173902] systemd[1]: Starting First Boot Home Area Wizard...1834sshClient # [ 9.243457] network-addresses-eth1-start[623]: adding address 192.168.1.2/24... done1835sshClient # [ 9.246191] systemd-logind[544]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1836sshClient # [ 9.265449] network-addresses-eth1-start[623]: adding address 2001:db8:1::2/64... done1837machine # [ 9.420893] Console: switching to colour frame buffer device 160x501838machine # [ 9.461730] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1839machine # [ 9.239591] network-addresses-eth1-start[624]: adding address 192.168.1.1/24... done1840machine # [ 9.322891] network-addresses-eth1-start[624]: adding address 2001:db8:1::1/64... done1841machine # [ 9.324135] systemd[1]: Finished Address configuration of eth1.1842machine # [ 9.329638] systemd-logind[552]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1843machine # [ 9.331925] systemd-logind[552]: Watching system buttons on /dev/input/event2 (Power Button)1844machine # [ 9.336258] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1845machine # [ 9.337243] systemd[1]: Stopped Virtual Console Setup.1846sshClient # [ 9.288264] systemd-logind[544]: Watching system buttons on /dev/input/event2 (Power Button)1847sshClient # [ 9.295275] systemd[1]: Finished Address configuration of eth1.1848machine # [ 9.362069] systemd[1]: Starting Virtual Console Setup...1849machine # [ 9.423084] systemd[1]: Created slice Slice /system/systemd-mute-console.1850machine # [ 9.431342] systemd[1]: Started Console Output Muting Service (PID 637/UID 0).1851sshClient # [ 9.383746] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1852sshClient # [ 9.387244] systemd[1]: Stopped Virtual Console Setup.1853sshClient # [ 9.398648] systemd[1]: Starting Virtual Console Setup...1854machine # [ 9.454655] systemd[1]: Finished Extra networking commands..1855sshClient # [ 9.536818] Console: switching to colour frame buffer device 160x501856sshClient # [ 9.410238] systemd[1]: Finished Extra networking commands..1857machine # [ 9.461288] systemd[1]: Reached target Network.1858sshClient # [ 9.417551] dhcpcd[639]: dhcpcd-10.3.2 starting1859sshClient # [ 9.421082] systemd[1]: Reached target Network.1860sshClient # [ 9.429466] dhcpcd[694]: dev: loaded udev1861sshClient # [ 9.571352] ppdev: user-space parallel port driver1862sshClient # [ 9.588320] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1863sshClient # [ 9.597016] 8021q: 802.1Q VLAN Support v1.81864sshClient # [ 9.597460] 8021q: adding VLAN 0 to HW filter on device eth11865machine # [ 9.516340] dhcpcd[661]: dhcpcd-10.3.2 starting1866machine # [ 9.527456] dhcpcd[707]: dev: loaded udev1867sshClient # [ 9.626340] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1868sshClient # [ 9.503684] systemd-logind[544]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1869sshClient # [ 9.665069] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1870machine # [ 9.589773] systemd-logind[552]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1871sshClient # [ 9.593257] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1872sshClient # [ 9.612128] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1873sshClient # [ 9.615479] systemd[1]: Stopped Virtual Console Setup.1874machine # [ 9.680815] sshd-keygen-start[562]: Generating public/private rsa key pair.1875sshClient # [ 9.634226] systemd[1]: Starting Virtual Console Setup...1876machine # [ 9.683243] sshd-keygen-start[562]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1877machine # [ 9.684846] sshd-keygen-start[562]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1878sshClient # [ 9.777249] cfg80211: Loading compiled-in X.509 certificates for regulatory database1879machine # [ 9.686960] sshd-keygen-start[562]: The key fingerprint is:1880machine # [ 9.687853] sshd-keygen-start[562]: SHA256:qsFIsQG+NAhhFaP+dJkANDwyYw4CjmK3Q/7Ed9HX+o8 root@machine1881machine # [ 9.688994] sshd-keygen-start[562]: The key's randomart image is:1882machine # [ 9.690553] sshd-keygen-start[562]: +---[RSA 4096]----+1883machine # [ 9.691513] sshd-keygen-start[562]: |O*.+. |1884machine # [ 9.692777] sshd-keygen-start[562]: |&=+ . . . |1885machine # [ 9.694484] sshd-keygen-start[562]: |XX++ . . . . |1886machine # [ 9.695233] sshd-keygen-start[562]: |=.*++ o . . . |1887machine # [ 9.695962] sshd-keygen-start[562]: | oo= * .S. . |1888machine # [ 9.696838] sshd-keygen-start[562]: | .oo= ... . |1889machine # [ 9.698247] sshd-keygen-start[562]: | ..o.. . |1890machine # [ 9.699549] sshd-keygen-start[562]: | o ..|1891machine # [ 9.701506] sshd-keygen-start[562]: | . E .|1892machine # [ 9.702327] sshd-keygen-start[562]: +----[SHA256]-----+1893machine # [ 9.735506] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1894sshClient # [ 9.697887] systemd[1]: Finished First Boot Home Area Wizard.1895sshClient # [ 9.702292] systemd[1]: Reached target First Boot Complete.1896machine # [ 9.756713] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1897machine # [ 9.757818] systemd[1]: Stopped Virtual Console Setup.1898sshClient # [ 9.710271] systemd[1]: Starting Save Transient machine-id to Disk...1899sshClient # [ 9.851316] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1900sshClient # [ 9.853455] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1901sshClient # [ 9.718344] systemd[1]: Starting Permit User Sessions...1902sshClient # [ 9.859451] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21903sshClient # [ 9.860414] cfg80211: failed to load regulatory.db1904machine # [ 9.780293] sshd-keygen-start[718]: Generating public/private ed25519 key pair.1905machine # [ 9.781216] sshd-keygen-start[718]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1906machine # [ 9.782350] sshd-keygen-start[718]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1907machine # [ 9.783555] sshd-keygen-start[718]: The key fingerprint is:1908machine # [ 9.784797] sshd-keygen-start[718]: SHA256:qI7oUEylURrKrrd8nyOTap4Mr2UyqD/Hi9rDqtadn08 root@machine1909machine # [ 9.786276] sshd-keygen-start[718]: The key's randomart image is:1910machine # [ 9.788095] sshd-keygen-start[718]: +--[ED25519 256]--+1911machine # [ 9.788807] sshd-keygen-start[718]: | o.o |1912machine # [ 9.789555] sshd-keygen-start[718]: |.. * |1913machine # [ 9.790262] sshd-keygen-start[718]: |..+ |1914machine # [ 9.791949] sshd-keygen-start[718]: |.o . |1915machine # [ 9.792841] sshd-keygen-start[718]: | .o . S |1916machine # [ 9.793544] sshd-keygen-start[718]: |o. . |1917machine # [ 9.794196] sshd-keygen-start[718]: |B.=.o.. E |1918machine # [ 9.794865] sshd-keygen-start[718]: |o#=BBo..o |1919machine # [ 9.795545] sshd-keygen-start[718]: |@O&*o=++.. |1920machine # [ 9.797100] sshd-keygen-start[718]: +----[SHA256]-----+1921sshClient # [ 9.893493] kvm_amd: TSC scaling supported1922sshClient # [ 9.894118] kvm_amd: Nested Virtualization enabled1923machine # [ 9.803085] systemd[1]: Starting Virtual Console Setup...1924sshClient # [ 9.894737] kvm_amd: Nested Paging enabled1925machine # [ 9.805410] systemd[1]: sshd-keygen.service: Deactivated successfully.1926sshClient # [ 9.896924] kvm_amd: LBR virtualization supported1927machine # [ 9.806482] systemd[1]: Finished SSH Host Keys Generation.1928sshClient # [ 9.899019] kvm_amd: Virtual VMLOAD VMSAVE supported1929sshClient # [ 9.899642] kvm_amd: Virtual GIF supported1930sshClient # [ 9.900917] kvm_amd: Virtual NMI enabled1931sshClient # [ 9.771560] systemd[1]: Finished Permit User Sessions.1932machine # [ 9.829136] systemd[1]: Starting SSH Daemon...1933sshClient # [ 9.786181] systemd[1]: Started Getty on tty1.1934sshClient # [ 9.786955] systemd[1]: Reached target Login Prompts.1935sshClient # [ 9.803071] systemd[1]: Finished Save Transient machine-id to Disk.1936sshClient # [ 9.955849] 8021q: adding VLAN 0 to HW filter on device eth01937sshClient # [ 9.817061] dhcpcd[694]: eth0: waiting for carrier1938sshClient # [ 9.817975] dhcpcd[694]: eth0: carrier acquired1939sshClient # [ 9.829771] dhcpcd[694]: DUID 00:01:00:01:32:2a:4a:84:52:54:00:12:34:561940sshClient # [ 9.830705] dhcpcd[694]: eth0: IAID 00:12:34:561941sshClient # [ 9.831379] dhcpcd[694]: eth0: adding address fe80::5054:ff:fe12:34561942sshClient # [ 9.981635] EDAC MC: Ver: 3.0.01943machine: (finished: waiting for unit systemd-homed.service, in 10.58 seconds)1944machine # [ 9.928239] sshd[723]: Server listening on 0.0.0.0 port 22.1945machine: waiting for Please enter user name to create to appear on tty 11946machine # [ 9.930621] sshd[723]: Server listening on :: port 22.1947machine # [ 9.933886] systemd[1]: Started SSH Daemon.1948machine # [ 9.986826] dhcpcd[707]: eth0: waiting for carrier1949machine # [ 9.989542] dhcpcd[707]: libudev: received NULL device1950machine # [ 9.991430] dhcpcd[707]: libudev: received NULL device1951machine # [ 9.994161] dhcpcd[707]: eth0: carrier acquired1952machine # [ 10.007209] dhcpcd[707]: DUID 00:01:00:01:32:2a:4a:85:52:54:00:12:34:561953machine # [ 10.008368] dhcpcd[707]: eth0: IAID 00:12:34:561954machine # [ 10.009439] dhcpcd[707]: eth0: adding address fe80::5054:ff:fe12:34561955machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 0.09 seconds)1956machine: sending keys 'test-homed-user\n'1957sshClient # [ 10.050841] systemd-vconsole-setup[701]: Configuration of first virtual console was skipped, ignoring remaining ones.1958sshClient # [ 10.054644] systemd[1]: Finished Virtual Console Setup.1959sshClient # [ 10.096306] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1960machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)1961machine: waiting for Please enter new password for user test-homed-user: to appear on tty 11962machine # [ 10.237891] systemd-vconsole-setup[720]: Configuration of first virtual console was skipped, ignoring remaining ones.1963machine # [ 10.241373] systemd[1]: Finished Virtual Console Setup.1964machine # [ 10.271675] dhcpcd[707]: eth0: soliciting a DHCP lease1965machine # [ 10.293511] dhcpcd[707]: eth0: offered 10.0.2.15 from 10.0.2.21966machine # [ 10.296193] dhcpcd[707]: eth0: probing address 10.0.2.15/241967sshClient # [ 10.257804] dhcpcd[694]: eth0: soliciting a DHCP lease1968sshClient # [ 10.424352] NET: Registered PF_PACKET protocol family1969sshClient # [ 10.291759] dhcpcd[694]: eth0: offered 10.0.2.15 from 10.0.2.21970sshClient # [ 10.296354] dhcpcd[694]: eth0: probing address 10.0.2.15/241971machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.10 seconds)1972machine: sending keys 'foobarfoo\n'1973machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)1974machine: waiting for (repeat) to appear on tty 11975machine # [ 11.612271] dhcpcd[707]: eth0: soliciting an IPv6 router1976machine # [ 11.615153] dhcpcd[707]: eth0: Router Advertisement from fe80::21977machine # [ 11.617348] dhcpcd[707]: eth0: adding address fec0::5054:ff:fe12:3456/641978machine # [ 11.619499] dhcpcd[707]: eth0: adding route to fec0::/641979machine # [ 11.621301] dhcpcd[707]: eth0: adding default route via fe80::21980sshClient # [ 11.618445] dhcpcd[694]: eth0: soliciting an IPv6 router1981sshClient # [ 11.621334] dhcpcd[694]: eth0: Router Advertisement from fe80::21982sshClient # [ 11.623493] dhcpcd[694]: eth0: adding address fec0::5054:ff:fe12:3456/641983sshClient # [ 11.625732] dhcpcd[694]: eth0: adding route to fec0::/641984sshClient # [ 11.627759] dhcpcd[694]: eth0: adding default route via fe80::21985machine: (finished: waiting for (repeat) to appear on tty 1, in 1.10 seconds)1986machine: sending keys 'foobarfoo\n'1987machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)1988machine: waiting for unit systemd-homed-firstboot.service1989machine # [ 15.004278] dhcpcd[707]: eth0: leased 10.0.2.15 for 86400 seconds1990machine # [ 15.006565] dhcpcd[707]: eth0: adding route to 10.0.2.0/241991machine # [ 15.008528] dhcpcd[707]: eth0: adding default route via 10.0.2.21992machine # [ 15.129694] systemd[1]: Started DHCP Client.1993sshClient # [ 15.632829] dhcpcd[694]: eth0: leased 10.0.2.15 for 86400 seconds1994sshClient # [ 15.636914] dhcpcd[694]: eth0: adding route to 10.0.2.0/241995sshClient # [ 15.639487] dhcpcd[694]: eth0: adding default route via 10.0.2.21996sshClient # [ 15.733376] systemd[1]: Started DHCP Client.1997sshClient # [ 15.735222] systemd[1]: Reached target Multi-User System.1998sshClient # [ 15.736488] systemd[1]: Startup finished in 839ms (kernel) + 4.091s (initrd) + 10.805s (userspace) = 15.736s.1999machine # [ 22.754653] systemd-homed[526]: Generating key pair for signing local user identity records.2000machine # [ 22.757827] systemd-homed[526]: Successfully created Ed25519 key pair.2001machine # [ 22.778085] systemd-homed[526]: test-homed-user: changing state absent → creating2002machine # [ 22.853310] systemd-homework[878]: Using automatic default storage of 'luks'.2003machine # [ 22.859152] systemd-homework[878]: Sizing home to 83% of available disk space, which is 737M.2004machine # [ 22.861155] systemd-homework[878]: Allocating image file completed.2005machine # [ 22.885771] systemd-homework[878]: Writing of partition table completed.2006machine # [ 22.887959] systemd-homework[878]: Setting up loopback device /dev/loop0 completed.2007machine # [ 24.210490] systemd-homework[878]: LUKS formatting completed.2008machine # [ 25.944872] systemd-homework[878]: Writing password to LUKS keyslot 0 completed.2009machine # [ 26.149690] systemd-homework[878]: LUKS activation by volume key succeeded.2010machine # [ 26.165759] systemd-homework[878]: Writing user record as LUKS token completed.2011machine # [ 26.166855] systemd-homework[878]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2012machine # [ 26.168510] systemd-homework[878]: Formatting /dev/mapper/home-test-homed-user as btrfs2013machine # [ 26.555262] systemd-homework[878]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid f53d6cd8-8249-4d71-8797-75597b60d4f8)2014machine # [ 26.558066] systemd-homework[878]: Formatting file system completed.2015machine # [ 26.559526] systemd[1]: proc-908-mounts.mount: Deactivated successfully.2016machine # [ 26.592805] systemd-homework[878]: Mounting file system completed.2017machine # [ 26.595069] systemd-homework[878]: Skeleton directory /etc/skel missing, ignoring.2018machine # [ 26.596113] systemd-homework[878]: Wrote embedded .identity file.2019machine # [ 26.597067] systemd-homework[878]: Replaced embedded blob dir with contents of system blob dir.2020machine # [ 26.599190] systemd-homework[878]: Recursive changing of ownership completed.2021machine # [ 26.600311] systemd-homework[878]: Changed top-level directory access mode to 0700.2022machine # [ 26.605157] systemd-homework[878]: Synchronized disk.2023machine # [ 26.606710] systemd-homework[878]: Discarded unused 646.4M.2024machine # [ 26.615844] systemd-homed[526]: block device /sys/devices/virtual/block/dm-0 has been removed.2025machine # [ 26.623349] systemd-homed[526]: block device /sys/devices/virtual/block/dm-0 has been removed.2026machine # [ 26.639176] systemd-homed[526]: block device /sys/devices/virtual/block/loop0 has been removed.2027machine # [ 26.642215] systemd-homework[878]: Moved image file into place.2028machine # [ 26.643155] systemd-homework[878]: Creation completed.2029machine # [ 26.643935] systemd-homework[878]: Image size is 737M, file system size is 719M, file system payload size is 719M, file system free is 712.9M.2030machine # [ 26.655810] systemd-homed[526]: test-homed-user: changing state creating → inactive2031machine # [ 26.659481] systemd[1]: Finished First Boot Home Area Wizard.2032machine # [ 26.661904] systemd[1]: systemd-mute-console@0-1-637_638-0.service: Deactivated successfully.2033machine # [ 26.665771] systemd[1]: Reached target First Boot Complete.2034machine # [ 26.669190] systemd[1]: Starting Save Transient machine-id to Disk...2035machine # [ 26.672046] systemd[1]: Starting Permit User Sessions...2036machine # [ 26.700920] systemd[1]: Finished Permit User Sessions.2037machine # [ 26.705499] systemd[1]: Started Getty on tty1.2038machine # [ 26.707935] systemd[1]: Reached target Login Prompts.2039machine # [ 26.709265] systemd[1]: Reached target Multi-User System.2040machine # [ 26.718145] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2041machine # [ 26.720302] systemd[1]: Finished Save Transient machine-id to Disk.2042machine # [ 26.724563] systemd[1]: Startup finished in 839ms (kernel) + 4.025s (initrd) + 21.859s (userspace) = 26.724s.2043machine: (finished: waiting for unit systemd-homed-firstboot.service, in 14.91 seconds)2044(finished: subtest: create systemd-homed user on first boot prompt, in 28.17 seconds)2045machine: must succeed: homectl update test-homed-user --offline -G wheel2046machine # [ 27.556534] systemd-homed[526]: test-homed-user: changing state inactive → updating2047machine # [ 27.561220] systemd-homework[954]: Offline update requested. Not touching embedded records.2048machine # [ 27.563222] systemd-homed[526]: Home test-homed-user is signed exclusively by our key, accepting.2049machine # [ 27.568695] systemd-homed[526]: test-homed-user: changing state updating → inactive2050machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.05 seconds)2051subtest: login as homed user2052machine: waiting for login: to appear on tty 12053machine: (finished: waiting for login: to appear on tty 1, in 0.04 seconds)2054machine: sending keys 'test-homed-user\n'2055machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)2056machine: waiting for Password: to appear on tty 12057machine # [ 27.997716] systemd-homed[526]: test-homed-user: changing state inactive → activating-for-acquire2058machine # [ 28.007646] systemd-homework[969]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2059machine # [ 28.013915] systemd-homed[526]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2060machine # [ 28.015747] systemd-homed[526]: test-homed-user: changing state activating-for-acquire → inactive2061machine # [ 28.017062] systemd-homed[526]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2062machine # [ 28.018434] systemd-homed[526]: Home test-homed-user already deactivated, no automatic deactivation needed.2063machine: (finished: waiting for Password: to appear on tty 1, in 1.14 seconds)2064machine: sending keys 'foobarfoo\n'2065machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2066machine: waiting for success: pgrep -u test-homed-user -t tty1 bash2067machine # [ 29.112504] systemd-homed[526]: test-homed-user: changing state inactive → activating-for-acquire2068machine # [ 29.154246] systemd-homework[981]: Provided password unlocks user record.2069machine # [ 29.162374] systemd-homework[981]: Successfully locked image file '/home/test-homed-user.home'.2070machine # [ 29.168754] systemd-homework[981]: Allocated additional 646.4M.2071machine # [ 29.315344] loop1: detected capacity change from 0 to 15052802072machine # [ 29.174045] systemd-homework[981]: Setting up loopback device /dev/loop1 completed.2073machine # [ 29.997937] systemd-homework[981]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2074machine # [ 30.022773] systemd-homework[981]: Provided password unlocks user record.2075machine # [ 30.027517] systemd-homework[981]: Probing file system completed (found btrfs).2076machine # [ 30.032149] systemd-homework[981]: No fsck for file system btrfs installed, ignoring.2077machine # [ 30.176619] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (981)2078machine # [ 30.178553] BTRFS info (device dm-0): first mount of filesystem f53d6cd8-8249-4d71-8797-75597b60d4f82079machine # [ 30.179925] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2080machine # [ 30.183660] BTRFS info (device dm-0): enabling free space tree2081machine # [ 30.184217] BTRFS info (device dm-0): use zstd compression, level 12082machine # [ 30.042796] systemd-homework[981]: Mounting file system completed.2083machine # [ 30.044707] systemd-homework[981]: Discovered used loopback device /dev/loop1.2084machine # [ 30.045683] systemd-homework[981]: offset = 1048576, size = 770703360, image = 7728005122085machine # [ 30.056138] systemd-homework[981]: Ready to resize image size 737M → 888M, partition size 735M → 886M, file system size 719M → 870M.2086machine # [ 30.057921] systemd-homework[981]: Growing of image file from 737M to 888M completed.2087machine # [ 30.203325] loop1: detected capacity change from 1505280 to 18145282088machine # [ 30.062708] systemd-homework[981]: Refreshing loop device size completed.2089machine # [ 30.077714] systemd-homework[981]: Growing of partition completed.2090machine # [ 30.243271] async_tx: api initialized (async)2091machine # [ 30.146570] systemd-homework[981]: LUKS device growing completed.2092machine # [ 30.297438] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 753926144 to 9122611202093machine # [ 30.158310] systemd-homework[981]: File system resizing from 719M to 870M completed.2094machine # [ 30.159291] systemd-homework[981]: Synchronized disk.2095machine # [ 30.159967] systemd-homework[981]: Synchronized disk.2096machine # [ 30.162105] systemd-homework[981]: Resizing completed.2097machine # [ 30.162800] systemd-homework[981]: Image size is 888M, file system size is 870M, file system payload size is 870M, file system free is 863.9M.2098machine # [ 30.165106] systemd-homework[981]: Read embedded .identity file.2099machine # [ 30.187171] systemd-homework[981]: Provided password unlocks user record.2100machine # [ 30.188265] systemd-homework[981]: Reconciling header user identity completed (host version was newer).2101machine # [ 30.189540] systemd-homework[981]: Reconciling embedded user identity completed (host version was newer).2102machine # [ 30.205534] systemd-homework[981]: Wrote LUKS header user record.2103machine # [ 30.206687] systemd-homework[981]: Wrote embedded .identity file.2104machine # [ 30.207559] systemd-homework[981]: Replaced embedded blob dir with contents of system blob dir.2105machine # [ 30.208629] systemd-homework[981]: Recursive changing of ownership not necessary, skipped.2106machine # [ 30.214340] systemd-homework[981]: Synchronized disk.2107machine # [ 30.215186] systemd-homework[981]: Moving to final mount point /home/test-homed-user completed.2108machine # [ 30.236600] systemd-homework[981]: Activation completed.2109machine # [ 30.237389] systemd-homework[981]: Image size is 886M, file system size is 870M, file system payload size is 870M, file system free is 863.9M.2110machine # [ 30.249219] systemd-homed[526]: Home test-homed-user is signed exclusively by our key, accepting.2111machine # [ 30.255156] login[945]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired.2112machine # [ 30.256570] systemd-homed[526]: test-homed-user: changing state activating-for-acquire → active2113machine # [ 30.262775] systemd-homed[526]: test-homed-user: changing state active → resizing-while-active2114machine # [ 30.273032] systemd-homework[1024]: Successfully acquired home volume key from kernel keyring.2115machine # [ 30.274832] systemd-homework[1024]: LUKS volume key from keyring unlocks user record.2116machine # [ 30.333619] login[945]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0)2117machine # [ 30.358539] systemd-homework[1024]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2118machine # [ 30.378257] systemd[1]: Created slice Slice /user/60388.2119machine # [ 30.383569] systemd[1]: Starting User Runtime Directory /run/user/60388...2120machine # [ 30.398304] systemd-logind[552]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'.2121machine # [ 30.443695] systemd[1]: Finished User Runtime Directory /run/user/60388.2122machine # [ 30.458781] systemd[1]: Starting User Manager for UID 60388...2123machine # [ 30.499922] (systemd)[1029]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2124machine # [ 30.553341] (systemd)[1029]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2125machine # [ 30.560942] systemd-logind[552]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2126machine # [ 30.604421] systemd[1029]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2127machine # [ 30.653965] systemd-homework[1024]: Successfully re-activated LUKS device.2128machine # [ 30.657158] systemd-homework[1024]: LUKS volume key from keyring unlocks user record.2129machine # [ 30.658782] systemd-homework[1024]: Discovered used loopback device /dev/loop1.2130machine # [ 30.660090] systemd-homework[1024]: Read embedded .identity file.2131machine # [ 30.660896] systemd-homework[1024]: LUKS volume key from keyring unlocks user record.2132machine # [ 30.662183] systemd-homework[1024]: Reconciling header user identity completed (host version was newer).2133machine # [ 30.663822] systemd-homework[1024]: Reconciling embedded user identity completed (host version was newer).2134machine # [ 30.665406] systemd-homework[1024]: offset = 1048576, size = 929038336, image = 9311354882135machine # [ 30.680638] systemd-homework[1024]: Ready to resize image size 888M → 758M, partition size 886M → 756M, file system size 870M → 740M.2136machine # [ 30.682553] systemd-homework[1024]: Wrote embedded .identity file.2137machine # [ 30.683580] systemd-homework[1024]: Replaced embedded blob dir with contents of system blob dir.2138machine # [ 30.685078] systemd-homework[1024]: Backing file is fully allocated already.2139machine # [ 30.831398] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 912261120 to 7759462402140machine # [ 30.690499] systemd-homework[1024]: File system resizing from 870M to 740M completed.2141machine # [ 30.696377] systemd-homework[1024]: Synchronized disk.2142machine # [ 30.742290] systemd-homework[1024]: LUKS device shrinking completed.2143machine # [ 30.886381] loop1: detected capacity change from 1814528 to 15482882144machine # [ 30.749057] systemd-homework[1024]: Refreshing loop device size completed.2145machine # [ 30.750725] systemd-homework[1024]: Shrinking of image file completed.2146machine # [ 30.771861] systemd-homework[1024]: Shrinking of partition completed.2147machine # [ 30.789068] systemd-homework[1024]: Wrote LUKS header user record.2148machine # [ 30.791290] systemd-homework[1024]: Synchronized disk.2149machine # [ 30.793290] systemd-homework[1024]: Resizing completed.2150machine # [ 30.795737] systemd-homework[1024]: Image size is 758M, file system size is 740M, file system payload size is 740M, file system free is 733.9M.2151machine # [ 30.804146] systemd-homed[526]: Home test-homed-user is signed exclusively by our key, accepting.2152machine # [ 30.813141] systemd-homed[526]: test-homed-user: changing state resizing-while-active → active2153machine # [ 30.815310] systemd-homed[526]: Rebalancing complete.2154machine # [ 30.881092] systemd[1029]: Queued start job for default target Main User Target.2155machine # [ 30.883856] systemd[1029]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2156machine # [ 30.890332] systemd[1029]: Created slice User Application Slice.2157machine # [ 30.891296] systemd[1029]: Started Daily Cleanup of User's Temporary Directories.2158machine # [ 30.892318] systemd[1029]: Reached target Paths.2159machine # [ 30.894045] systemd[1029]: Reached target Timers.2160machine # [ 30.897057] systemd[1029]: Starting D-Bus User Message Bus Socket...2161machine # [ 30.899717] systemd[1029]: Starting Create User Files and Directories...2162machine # [ 30.930596] systemd[1029]: Finished Create User Files and Directories.2163machine # [ 30.970603] systemd[1029]: Listening on D-Bus User Message Bus Socket.2164machine # [ 30.971855] systemd[1029]: Reached target Sockets.2165machine # [ 30.973507] systemd[1029]: Reached target Basic System.2166machine # [ 30.974404] systemd[1]: Started User Manager for UID 60388.2167machine # [ 30.978361] systemd[1029]: Starting Run user-specific NixOS activation...2168machine # [ 30.981137] systemd[1]: Started Session 1 of User test-homed-user.2169machine # [ 31.023694] systemd[1029]: Finished Run user-specific NixOS activation.2170machine # [ 31.025810] systemd[1029]: Reached target Main User Target.2171machine # [ 31.026624] systemd[1029]: Startup finished in 435ms.2172machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.20 seconds)2173machine: sending keys 'whoami > /tmp/2\n'2174machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.17 seconds)2175machine: waiting for file '/tmp/2'2176machine: (finished: waiting for file '/tmp/2', in 1.06 seconds)2177machine: must succeed: cat /tmp/22178machine: (finished: must succeed: cat /tmp/2, in 0.02 seconds)2179(finished: subtest: login as homed user, in 4.91 seconds)2180subtest: login as regular user2181sshClient: waiting for login: to appear on tty 12182sshClient: waiting for the VM to finish booting2183sshClient: Guest shell says: b'Spawning backdoor root shell...\n'2184sshClient: connected to guest root shell2185sshClient: (connecting took 0.00 seconds)2186sshClient: (finished: waiting for the VM to finish booting, in 0.00 seconds)2187sshClient: (finished: waiting for login: to appear on tty 1, in 0.09 seconds)2188sshClient: sending keys 'test-normal-user\n'2189sshClient: (finished: sending keys 'test-normal-user\n', in 0.18 seconds)2190sshClient: waiting for Password: to appear on tty 12191sshClient: (finished: waiting for Password: to appear on tty 1, in 1.15 seconds)2192sshClient: sending keys 'foobarfoo\n'2193sshClient: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2194sshClient: waiting for success: pgrep -u test-normal-user bash2195sshClient # [ 34.052875] login[713]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0)2196sshClient # [ 34.101105] systemd[1]: Created slice Slice /user/1000.2197sshClient # [ 34.105857] systemd[1]: Starting User Runtime Directory /run/user/1000...2198sshClient # [ 34.120135] systemd-logind[544]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'.2199sshClient # [ 34.148330] systemd[1]: Finished User Runtime Directory /run/user/1000.2200sshClient # [ 34.154771] systemd[1]: Starting User Manager for UID 1000...2201sshClient # [ 34.188450] (systemd)[824]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0)2202sshClient # [ 34.193964] systemd-logind[544]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'.2203sshClient # [ 34.221239] systemd[824]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2204sshClient # [ 34.384431] systemd[824]: Queued start job for default target Main User Target.2205sshClient # [ 34.386366] systemd[824]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2206sshClient # [ 34.388680] systemd[824]: Created slice User Application Slice.2207sshClient # [ 34.390633] systemd[824]: Started Daily Cleanup of User's Temporary Directories.2208sshClient # [ 34.391636] systemd[824]: Reached target Paths.2209sshClient # [ 34.392357] systemd[824]: Reached target Timers.2210sshClient # [ 34.395070] systemd[824]: Starting D-Bus User Message Bus Socket...2211sshClient # [ 34.397485] systemd[824]: Starting Create User Files and Directories...2212sshClient # [ 34.431979] systemd[824]: Finished Create User Files and Directories.2213sshClient # [ 34.471455] systemd[824]: Listening on D-Bus User Message Bus Socket.2214sshClient # [ 34.472675] systemd[824]: Reached target Sockets.2215sshClient # [ 34.474661] systemd[824]: Reached target Basic System.2216sshClient # [ 34.475458] systemd[1]: Started User Manager for UID 1000.2217sshClient # [ 34.478668] systemd[824]: Starting Run user-specific NixOS activation...2218sshClient # [ 34.479961] systemd[1]: Started Session 1 of User test-normal-user.2219sshClient # [ 34.523657] systemd[824]: Finished Run user-specific NixOS activation.2220sshClient # [ 34.525383] systemd[824]: Reached target Main User Target.2221sshClient # [ 34.526391] systemd[824]: Startup finished in 314ms.2222sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.15 seconds)2223sshClient: sending keys 'whoami > /tmp/1\n'2224sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.17 seconds)2225sshClient: waiting for file '/tmp/1'2226sshClient: (finished: waiting for file '/tmp/1', in 1.09 seconds)2227sshClient: must succeed: cat /tmp/12228sshClient: (finished: must succeed: cat /tmp/1, in 0.04 seconds)2229(finished: subtest: login as regular user, in 3.97 seconds)2230subtest: add homed ssh authorized key2231sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n'2232sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.49 seconds)2233sshClient: waiting for file '/tmp/id_ed25519.pub'2234sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.07 seconds)2235sshClient: must succeed: cat /tmp/id_ed25519.pub2236sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.03 seconds)2237machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILI3e5IR5bYtF6kxq3F/W4kIm57VNc5nFEXyDZo5XhdR test-normal-user@sshClient'2238machine # [ 38.099987] systemd-homed[526]: test-homed-user: changing state active → updating-while-active2239machine # [ 38.110699] systemd-homework[1078]: Offline update requested. Not touching embedded records.2240machine # [ 38.120905] systemd-homed[526]: test-homed-user: changing state updating-while-active → active2241machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILI3e5IR5bYtF6kxq3F/W4kIm57VNc5nFEXyDZo5XhdR test-normal-user@sshClient', in 0.08 seconds)2242machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed255192243machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.03 seconds)2244(finished: subtest: add homed ssh authorized key, in 1.71 seconds)2245subtest: change homed user password2246machine: sending keys 'passwd; echo $? > /tmp/3\n'2247machine: (finished: sending keys 'passwd; echo $? > /tmp/3\n', in 0.26 seconds)2248machine: waiting for New password: to appear on tty 12249machine: (finished: waiting for New password: to appear on tty 1, in 1.15 seconds)2250machine: sending keys 'barfoobar\n'2251machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2252machine: waiting for Retype new password: to appear on tty 12253machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.12 seconds)2254machine: sending keys 'barfoobar\n'2255machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2256??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead.2257 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 5732258machine: must succeed: sleep 4.02259machine # [ 41.016391] systemd-homed[526]: test-homed-user: changing state active → passwd-while-active2260machine # [ 41.722921] systemd-homework[1117]: No valid password for LUKS superblock.2261machine # [ 44.034921] systemd-homed[526]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2262machine # [ 44.039782] systemd-homed[526]: test-homed-user: changing state passwd-while-active → active2263machine: (finished: must succeed: sleep 4.0, in 4.05 seconds)2264machine: sending keys 'foobarfoo\n'2265machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2266machine: waiting for file '/tmp/3'2267machine # [ 45.172404] systemd-homed[526]: test-homed-user: changing state active → passwd-while-active2268machine # [ 46.457877] systemd-homework[1123]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2269machine # [ 46.587074] systemd-homework[1123]: Successfully re-activated LUKS device.2270machine # [ 46.625428] systemd-homework[1123]: Provided password unlocks user record.2271machine # [ 46.626796] systemd-homework[1123]: Discovered used loopback device /dev/loop1.2272machine # [ 46.627833] systemd-homework[1123]: Read embedded .identity file.2273machine # [ 46.664077] systemd-homework[1123]: Provided password unlocks user record.2274machine # [ 46.665039] systemd-homework[1123]: Reconciling header user identity completed (host version was newer).2275machine # [ 46.666161] systemd-homework[1123]: Reconciling embedded user identity completed (host version was newer).2276machine # [ 49.954892] systemd-homework[1123]: Added LUKS key slot 1.2277machine # [ 49.986457] systemd-homework[1123]: Destroyed LUKS key slot 0.2278machine # [ 49.996561] systemd-homework[1123]: Wrote LUKS header user record.2279machine # [ 49.997771] systemd-homework[1123]: Wrote embedded .identity file.2280machine # [ 49.998782] systemd-homework[1123]: Replaced embedded blob dir with contents of system blob dir.2281machine # [ 50.005577] systemd-homework[1123]: Synchronized disk.2282machine # [ 50.008786] systemd-homework[1123]: Everything completed.2283machine # [ 50.021552] passwd[1091]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user.2284machine # [ 50.025365] systemd-homed[526]: test-homed-user: changing state passwd-while-active → active2285machine: (finished: waiting for file '/tmp/3', in 5.21 seconds)2286machine: must succeed: cat /tmp/32287machine: (finished: must succeed: cat /tmp/3, in 0.03 seconds)2288(finished: subtest: change homed user password, in 12.12 seconds)2289subtest: escalate to root from homed user2290machine: sending keys 'sudo id | tee /tmp/4\n'2291machine: (finished: sending keys 'sudo id | tee /tmp/4\n', in 0.22 seconds)2292machine: waiting for password for test-homed-user to appear on tty 12293machine # [ 50.759034] systemd-homed[526]: test-homed-user: changing state active → authenticating-for-acquire2294machine # [ 50.764682] systemd-homework[1161]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2295machine # [ 50.771700] systemd-homed[526]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2296machine # [ 50.773749] systemd-homed[526]: test-homed-user: changing state authenticating-for-acquire → active2297machine: (finished: waiting for password for test-homed-user to appear on tty 1, in 1.12 seconds)2298machine: sending keys 'barfoobar\n'2299machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2300machine: waiting for file '/tmp/4'2301machine: (finished: waiting for file '/tmp/4', in 0.04 seconds)2302machine: waiting for success: grep uid=0 /tmp/42303machine # [ 51.810219] systemd-homed[526]: test-homed-user: changing state active → authenticating-for-acquire2304machine # [ 51.835102] systemd-homework[1177]: Provided password unlocks user record.2305machine # [ 52.397077] systemd-homework[1177]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2306machine # [ 52.525867] systemd-homework[1177]: Successfully re-activated LUKS device.2307machine # [ 52.546877] systemd-homework[1177]: Provided password unlocks user record.2308machine # [ 52.548296] systemd-homework[1177]: Discovered used loopback device /dev/loop1.2309machine # [ 52.549324] systemd-homework[1177]: Read embedded .identity file.2310machine # [ 52.568198] systemd-homework[1177]: Provided password unlocks user record.2311machine # [ 52.569317] systemd-homework[1177]: Reconciling user identities completed (host and header version were identical).2312machine # [ 52.570611] systemd-homework[1177]: Reconciling embedded user identity completed (host and embedded version were identical).2313machine # [ 52.579366] systemd-homework[1177]: Everything completed.2314machine # [ 52.583713] systemd-homed[526]: Home test-homed-user is signed exclusively by our key, accepting.2315machine # [ 52.591380] systemd-homed[526]: test-homed-user: changing state authenticating-for-acquire → active2316machine # [ 52.593434] sudo[1158]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired.2317machine # [ 52.599900] sudo[1158]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id2318machine # [ 52.614053] sudo[1158]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388)2319machine # [ 52.626645] sudo[1158]: pam_unix(sudo:session): session closed for user root2320machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.09 seconds)2321(finished: subtest: escalate to root from homed user, in 2.57 seconds)2322subtest: log out and deactivate homed user's home area2323machine: sending keys 'exit\n'2324machine: (finished: sending keys 'exit\n', in 0.05 seconds)2325machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive'2326machine # [ 52.938791] login[945]: pam_unix(login:session): session closed for user test-homed-user2327machine # [ 52.944370] login[945]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used.2328machine # [ 52.955411] systemd[1]: getty@tty1.service: Deactivated successfully.2329machine # [ 52.962871] systemd[1]: session-1.scope: Deactivated successfully.2330machine # [ 52.967359] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2331machine # [ 52.971500] systemd-logind[552]: Session 1 logged out. Waiting for processes to exit.2332machine # [ 52.974365] systemd[1]: Started Getty on tty1.2333machine # [ 52.977324] systemd-logind[552]: Removed session 1.2334machine # [ 63.204565] systemd[1]: Stopping User Manager for UID 60388...2335machine # [ 63.216192] systemd[1029]: Activating special unit Exit the Session...2336machine # [ 63.218525] systemd[1029]: Stopped target Main User Target.2337machine # [ 63.222779] systemd[1029]: Stopped Run user-specific NixOS activation.2338machine # [ 63.226413] systemd[1029]: Stopped target Basic System.2339machine # [ 63.229931] systemd[1029]: Stopped target Paths.2340machine # [ 63.233292] systemd[1029]: Stopped target Sockets.2341machine # [ 63.236289] systemd[1029]: Stopped target Timers.2342machine # [ 63.239487] systemd[1029]: Stopped Daily Cleanup of User's Temporary Directories.2343machine # [ 63.242427] systemd[1029]: Closed D-Bus User Message Bus Socket.2344machine # [ 63.244551] systemd[1029]: Stopped Create User Files and Directories.2345machine # [ 63.248305] systemd[1029]: Removed slice User Application Slice.2346machine # [ 63.250406] systemd[1029]: Reached target Shutdown.2347machine # [ 63.252487] systemd[1029]: Finished Exit the Session.2348machine # [ 63.254212] systemd[1029]: Reached target Exit the Session.2349machine # [ 63.259819] systemd-homed[526]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2350machine # [ 63.267612] systemd-logind[552]: Removed session 2.2351machine # [ 63.269268] systemd-homed[526]: test-homed-user: changing state active → deactivating2352machine # [ 63.271281] systemd[1]: user@60388.service: Deactivated successfully.2353machine # [ 63.272352] systemd[1]: Stopped User Manager for UID 60388.2354machine # [ 63.278948] systemd-homework[1253]: Successfully acquired home volume key from kernel keyring.2355machine # [ 63.281186] systemd-homework[1253]: Discarded unused 668.1M.2356machine # [ 63.290111] systemd-homework[1253]: Syncing completed.2357machine # [ 63.292328] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully.2358machine # [ 63.298845] systemd[1]: Stopping User Runtime Directory /run/user/60388...2359machine # [ 63.343608] systemd[1]: run-user-60388.mount: Deactivated successfully.2360machine # [ 63.348249] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully.2361machine # [ 63.352511] systemd[1]: Stopped User Runtime Directory /run/user/60388.2362machine # [ 63.359883] systemd-homework[1253]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2363machine # [ 63.523142] systemd-homework[1253]: Successfully re-activated LUKS device.2364machine # [ 63.524505] systemd-homework[1253]: Discovered used loopback device /dev/loop1.2365machine # [ 63.525929] systemd-homework[1253]: offset = 1048576, size = 792723456, image = 7948206082366machine # [ 63.540777] systemd-homework[1253]: Ready to resize image size 758M → 274M, partition size 756M → 272M, file system size 740M → 256M.2367machine # [ 63.542915] systemd-homework[1253]: Allocated additional 668.1M.2368machine # [ 63.691646] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 775946240 to 2684354562369machine # [ 63.550684] systemd-homework[1253]: File system resizing from 740M to 256M completed.2370machine # [ 63.551813] systemd-homework[1253]: Synchronized disk.2371machine # [ 63.693240] systemd-homework[1253]: LUKS device shrinking completed.2372machine # [ 63.837191] loop1: detected capacity change from 1548288 to 5570562373machine # [ 63.697096] systemd-homework[1253]: Refreshing loop device size completed.2374machine # [ 63.698132] systemd-homework[1253]: Shrinking of image file completed.2375machine # [ 63.719363] systemd-homework[1253]: Shrinking of partition completed.2376machine # [ 63.720405] systemd-homework[1253]: Synchronized disk.2377machine # [ 63.721115] systemd-homework[1253]: Resizing completed.2378machine # [ 63.721813] systemd-homework[1253]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M.2379machine # [ 63.865509] BTRFS info (device dm-0): last unmount of filesystem f53d6cd8-8249-4d71-8797-75597b60d4f82380machine # [ 63.726434] systemd-homework[1253]: Unmounting completed.2381machine # [ 63.727529] systemd-homework[1253]: Discovered used LUKS device /dev/mapper/home-test-homed-user.2382machine # [ 63.729340] systemd-homework[1253]: Device home-test-homed-user is not active.2383machine # [ 63.737490] systemd-homed[526]: block device /sys/devices/virtual/block/dm-0 has been removed.2384machine # [ 63.742839] systemd-homework[1253]: Everything completed.2385machine # [ 63.750854] systemd-homed[526]: test-homed-user: changing state deactivating → inactive2386machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 11.67 seconds)2387(finished: subtest: log out and deactivate homed user's home area, in 11.73 seconds)2388subtest: ssh as homed user2389sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n'2390sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.78 seconds)2391sshClient: waiting for Please enter password for user to appear on tty 12392machine # [ 66.474861] systemd-homed[526]: test-homed-user: changing state inactive → activating-for-acquire2393machine # [ 66.480269] systemd-homework[1289]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2394machine # [ 66.488327] systemd-homed[526]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2395machine # [ 66.490187] systemd-homed[526]: test-homed-user: changing state activating-for-acquire → inactive2396machine # [ 66.491415] systemd-homed[526]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2397machine # [ 66.492844] systemd-homed[526]: Home test-homed-user already deactivated, no automatic deactivation needed.2398machine # [ 66.494563] sshd-session[1285]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error2399machine # [ 66.496352] sshd-session[1285]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation.2400machine # [ 66.498570] sshd-session[1285]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 41638 ssh2: ED25519 SHA256:TtYo4Ztv5R9Jzr53h4bpTdRJYQ84m4T9F+OvPHLQCrA2401machine # [ 66.542909] sshd-session[1285]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0)2402machine # [ 66.558598] systemd[1]: Starting User Runtime Directory /run/user/60388...2403machine # [ 66.562029] systemd-logind[552]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'.2404machine # [ 66.593388] systemd[1]: Finished User Runtime Directory /run/user/60388.2405machine # [ 66.598530] systemd[1]: Started Session 3 of User test-homed-user.2406machine # [ 66.616715] sshd-session[1285]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2407machine # [ 66.619556] sshd-session[1285]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2408machine # [ 66.636150] systemd-homed[526]: test-homed-user: changing state inactive → activating2409machine # [ 66.641664] systemd-homework[1294]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2410machine # [ 66.648578] systemd-homed[526]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2411machine # [ 66.650397] systemd-homed[526]: test-homed-user: changing state activating → inactive2412sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.23 seconds)2413sshClient: sending keys 'barfoobar\n'2414sshClient: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2415machine: waiting for success: pgrep -u test-homed-user bash2416machine # [ 67.789290] systemd-homed[526]: test-homed-user: changing state inactive → activating2417machine # [ 67.822807] systemd-homework[1299]: Provided password unlocks user record.2418machine # [ 67.831386] systemd-homework[1299]: Successfully locked image file '/home/test-homed-user.home'.2419machine # [ 67.837488] systemd-homework[1299]: Backing file is fully allocated already.2420machine # [ 67.981857] loop1: detected capacity change from 0 to 5570562421machine # [ 67.840773] systemd-homework[1299]: Setting up loopback device /dev/loop1 completed.2422machine # [ 68.632456] systemd-homework[1299]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2423machine # [ 68.661158] systemd-homework[1299]: Provided password unlocks user record.2424machine # [ 68.666573] systemd-homework[1299]: Probing file system completed (found btrfs).2425machine # [ 68.668628] systemd-homework[1299]: No fsck for file system btrfs installed, ignoring.2426machine # [ 68.813333] BTRFS: device label test-homed-user devid 1 transid 18 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1299)2427machine # [ 68.815618] BTRFS info (device dm-0): first mount of filesystem f53d6cd8-8249-4d71-8797-75597b60d4f82428machine # [ 68.817173] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2429machine # [ 68.821437] BTRFS info (device dm-0): enabling free space tree2430machine # [ 68.821984] BTRFS info (device dm-0): use zstd compression, level 12431machine # [ 68.680791] systemd-homework[1299]: Mounting file system completed.2432machine # [ 68.682956] systemd-homework[1299]: Discovered used loopback device /dev/loop1.2433machine # [ 68.684165] systemd-homework[1299]: offset = 1048576, size = 285212672, image = 2873098242434machine # [ 68.695887] systemd-homework[1299]: Ready to resize image size 274M → 758M, partition size 272M → 756M, file system size 256M → 740M.2435machine # [ 68.697857] systemd-homework[1299]: Growing of image file from 274M to 758M completed.2436machine # [ 68.843159] loop1: detected capacity change from 557056 to 15482882437machine # [ 68.702840] systemd-homework[1299]: Refreshing loop device size completed.2438machine # [ 68.719350] systemd-homework[1299]: Growing of partition completed.2439machine # [ 68.757210] systemd-homework[1299]: LUKS device growing completed.2440machine # [ 68.905554] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 7759462402441machine # [ 68.765714] systemd-homework[1299]: File system resizing from 256M to 740M completed.2442machine # [ 68.769103] systemd-homework[1299]: Synchronized disk.2443machine # [ 68.769966] systemd-homework[1299]: Synchronized disk.2444machine # [ 68.770888] systemd-homework[1299]: Resizing completed.2445machine # [ 68.772155] systemd-homework[1299]: Image size is 758M, file system size is 740M, file system payload size is 740M, file system free is 733.9M.2446machine # [ 68.773665] systemd-homework[1299]: Read embedded .identity file.2447machine # [ 68.804440] systemd-homework[1299]: Provided password unlocks user record.2448machine # [ 68.806127] systemd-homework[1299]: Reconciling user identities completed (host and header version were identical).2449machine # [ 68.807785] systemd-homework[1299]: Reconciling embedded user identity completed (host and embedded version were identical).2450machine # [ 68.809961] systemd-homework[1299]: Recursive changing of ownership not necessary, skipped.2451machine # [ 68.811514] systemd-homework[1299]: Synchronized disk.2452machine # [ 68.813570] systemd-homework[1299]: Moving to final mount point /home/test-homed-user completed.2453machine # [ 68.849339] systemd-homework[1299]: Activation completed.2454machine # [ 68.850263] systemd-homework[1299]: Image size is 756M, file system size is 740M, file system payload size is 740M, file system free is 733.9M.2455machine # [ 68.861945] systemd-homed[526]: Home test-homed-user is signed exclusively by our key, accepting.2456machine # [ 68.870239] systemd-homed[526]: test-homed-user: changing state activating → active2457machine # [ 68.884337] systemd[1]: Starting User Manager for UID 60388...2458machine # [ 68.916281] (systemd)[1343]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2459machine # [ 68.961615] (systemd)[1343]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2460machine # [ 68.966721] systemd-logind[552]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2461machine # [ 69.002434] systemd[1343]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2462machine # [ 69.163536] systemd[1343]: Queued start job for default target Main User Target.2463machine # [ 69.165911] systemd[1343]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2464machine # [ 69.168302] systemd[1343]: Created slice User Application Slice.2465machine # [ 69.170055] systemd[1343]: Started Daily Cleanup of User's Temporary Directories.2466machine # [ 69.171042] systemd[1343]: Reached target Paths.2467machine # [ 69.171714] systemd[1343]: Reached target Timers.2468machine # [ 69.174749] systemd[1343]: Starting D-Bus User Message Bus Socket...2469machine # [ 69.177558] systemd[1343]: Starting Create User Files and Directories...2470machine # [ 69.214289] systemd[1343]: Finished Create User Files and Directories.2471machine # [ 69.217245] systemd[1343]: Listening on D-Bus User Message Bus Socket.2472machine # [ 69.218502] systemd[1343]: Reached target Sockets.2473machine # [ 69.220942] systemd[1343]: Reached target Basic System.2474machine # [ 69.221722] systemd[1]: Started User Manager for UID 60388.2475machine # [ 69.224427] systemd[1343]: Starting Run user-specific NixOS activation...2476machine # [ 69.271182] systemd[1343]: Finished Run user-specific NixOS activation.2477machine # [ 69.272437] systemd[1343]: Reached target Main User Target.2478machine # [ 69.274197] systemd[1343]: Startup finished in 281ms.2479machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.23 seconds)2480sshClient: sending keys 'whoami > /tmp/5\n'2481sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.17 seconds)2482machine: waiting for file '/tmp/5'2483machine: (finished: waiting for file '/tmp/5', in 1.08 seconds)2484machine: must succeed: cat /tmp/52485machine: (finished: must succeed: cat /tmp/5, in 0.04 seconds)2486sshClient: sending keys 'exit\n'2487sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2488sshClient: sending keys 'exit\n'2489sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2490(finished: subtest: ssh as homed user, in 6.74 seconds)2491(finished: run the VM test script, in 72.28 seconds)2492machine # [ 71.314943] sshd-session[1292]: Received disconnect from 2001:db8:1::2 port 41638:11: disconnected by user2493machine # [ 71.323747] sshd-session[1292]: Disconnected from user test-homed-user 2001:db8:1::2 port 416382494machine # [ 71.336273] sshd-session[1285]: pam_unix(sshd:session): session closed for user test-homed-user2495machine # [ 71.345518] sshd-session[1285]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used.2496machine # [ 71.351805] systemd[1]: session-3.scope: Deactivated successfully.2497machine # [ 71.358283] systemd-logind[552]: Session 3 logged out. Waiting for processes to exit.2498machine # [ 71.360833] systemd-logind[552]: Removed session 3.2499test script finished in 72.43s2500cleanup2501kill QemuMachine (pid 47)2502machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2503kill QemuMachine (pid 48)2504sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2505(finished: cleanup, in 0.34 seconds)2506additionally exposed symbols:2507 machine, sshClient,2508 vlan1,2509 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